builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-029 starttime: 1471395388.34 results: success (0) buildid: 20160816162614 builduid: 304ba1c11d5c4ff081e3d02b139f8327 revision: 4b48ad68a5945476857c08a9f67487fbdae51582 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 17:56:28.344151) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 17:56:28.344595) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 17:56:28.344887) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 17:56:28.396463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:56:28.396766) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 17:56:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.8M=0s 2016-08-16 17:56:28 (88.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134795 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:56:28.548187) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:56:28.548560) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023458 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:56:28.599013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:56:28.599419) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4b48ad68a5945476857c08a9f67487fbdae51582 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4b48ad68a5945476857c08a9f67487fbdae51582 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 17:56:28,802 truncating revision to first 12 chars 2016-08-16 17:56:28,802 Setting DEBUG logging. 2016-08-16 17:56:28,802 attempt 1/10 2016-08-16 17:56:28,802 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4b48ad68a594?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 17:56:29,137 unpacking tar archive at: fx-team-4b48ad68a594/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665778 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:56:29.280359) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 17:56:29.280663) ========= script_repo_revision: 4b48ad68a5945476857c08a9f67487fbdae51582 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 17:56:29.281057) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 17:56:29.281319) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 17:56:29.290348) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-16 17:56:29.290734) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:56:29 INFO - MultiFileLogger online at 20160816 17:56:29 in /builds/slave/test 17:56:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:56:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:56:29 INFO - {'append_to_log': False, 17:56:29 INFO - 'base_work_dir': '/builds/slave/test', 17:56:29 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:56:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:56:29 INFO - 'branch': 'Fx-Team-Non-PGO', 17:56:29 INFO - 'buildbot_json_path': 'buildprops.json', 17:56:29 INFO - 'config_files': ('talos/linux_config.py',), 17:56:29 INFO - 'default_actions': ('clobber', 17:56:29 INFO - 'read-buildbot-config', 17:56:29 INFO - 'download-and-extract', 17:56:29 INFO - 'populate-webroot', 17:56:29 INFO - 'create-virtualenv', 17:56:29 INFO - 'install', 17:56:29 INFO - 'run-tests'), 17:56:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:56:29 INFO - 'download_minidump_stackwalk': True, 17:56:29 INFO - 'download_symbols': 'ondemand', 17:56:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:56:29 INFO - 'tooltool.py': '/tools/tooltool.py', 17:56:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:56:29 INFO - '/tools/misc-python/virtualenv.py')}, 17:56:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:56:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:56:29 INFO - 'installer_path': 'installer.exe', 17:56:29 INFO - 'log_level': 'info', 17:56:29 INFO - 'log_name': 'talos', 17:56:29 INFO - 'log_to_console': True, 17:56:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:56:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:56:29 INFO - 'opt_config_files': (), 17:56:29 INFO - 'pip_index': False, 17:56:29 INFO - 'sps_profile': False, 17:56:29 INFO - 'sps_profile_interval': 0, 17:56:29 INFO - 'suite': 'dromaeojs', 17:56:29 INFO - 'system_bits': '32', 17:56:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:56:29 INFO - 'title': 'talos-linux64-ix-029', 17:56:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:56:29 INFO - 'use_talos_json': True, 17:56:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:56:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:56:29 INFO - 'work_dir': 'build'} 17:56:29 INFO - [mozharness: 2016-08-17 00:56:29.580157Z] Running clobber step. 17:56:29 INFO - Running pre-action listener: _resource_record_pre_action 17:56:29 INFO - Running main action method: clobber 17:56:29 INFO - rmtree: /builds/slave/test/build 17:56:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:56:30 INFO - Running post-action listener: _resource_record_post_action 17:56:30 INFO - [mozharness: 2016-08-17 00:56:30.036624Z] Finished clobber step (success) 17:56:30 INFO - [mozharness: 2016-08-17 00:56:30.036726Z] Running read-buildbot-config step. 17:56:30 INFO - Running pre-action listener: _resource_record_pre_action 17:56:30 INFO - Running main action method: read_buildbot_config 17:56:30 INFO - Using buildbot properties: 17:56:30 INFO - { 17:56:30 INFO - "project": "", 17:56:30 INFO - "product": "firefox", 17:56:30 INFO - "script_repo_revision": "production", 17:56:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:56:30 INFO - "repository": "", 17:56:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:56:30 INFO - "buildid": "20160816162614", 17:56:30 INFO - "pgo_build": "False", 17:56:30 INFO - "basedir": "/builds/slave/test", 17:56:30 INFO - "buildnumber": 3240, 17:56:30 INFO - "slavename": "talos-linux64-ix-029", 17:56:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:56:30 INFO - "platform": "ubuntu64_hw", 17:56:30 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 17:56:30 INFO - "branch": "fx-team", 17:56:30 INFO - "repo_path": "integration/fx-team", 17:56:30 INFO - "revision": "4b48ad68a5945476857c08a9f67487fbdae51582", 17:56:30 INFO - "stage_platform": "linux64", 17:56:30 INFO - "builduid": "304ba1c11d5c4ff081e3d02b139f8327", 17:56:30 INFO - "slavebuilddir": "test" 17:56:30 INFO - } 17:56:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:56:30 INFO - Running post-action listener: _resource_record_post_action 17:56:30 INFO - [mozharness: 2016-08-17 00:56:30.039127Z] Finished read-buildbot-config step (success) 17:56:30 INFO - [mozharness: 2016-08-17 00:56:30.039215Z] Running download-and-extract step. 17:56:30 INFO - Running pre-action listener: _resource_record_pre_action 17:56:30 INFO - Running main action method: download_and_extract 17:56:30 INFO - mkdir: /builds/slave/test/build/tests 17:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:30 INFO - trying https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:56:30 INFO - Downloading https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:56:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:56:30 INFO - Downloaded 1361 bytes. 17:56:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:56:30 INFO - Using the following test package requirements: 17:56:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:56:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:56:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:56:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:30 INFO - u'jsshell-linux-x86_64.zip'], 17:56:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:56:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:56:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:56:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:56:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:56:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:56:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:30 INFO - trying https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:56:30 INFO - Downloading https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:56:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:56:31 INFO - Downloaded 20265701 bytes. 17:56:31 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 17:56:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:35 INFO - trying https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:56:35 INFO - Downloading https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:56:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:56:36 INFO - Downloaded 20265701 bytes. 17:56:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 17:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:40 INFO - trying https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:56:40 INFO - Downloading https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:56:41 INFO - Downloaded 14413719 bytes. 17:56:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 17:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:42 INFO - trying https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:56:42 INFO - Downloading https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:56:43 INFO - Downloaded 55572700 bytes. 17:56:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:56:43 INFO - mkdir: /builds/slave/test/properties 17:56:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:56:43 INFO - Writing to file /builds/slave/test/properties/build_url 17:56:43 INFO - Contents: 17:56:43 INFO - build_url:https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:56:43 INFO - Running post-action listener: _resource_record_post_action 17:56:43 INFO - Running post-action listener: set_extra_try_arguments 17:56:43 INFO - [mozharness: 2016-08-17 00:56:43.988282Z] Finished download-and-extract step (success) 17:56:43 INFO - [mozharness: 2016-08-17 00:56:43.988582Z] Running populate-webroot step. 17:56:43 INFO - Running pre-action listener: _resource_record_pre_action 17:56:43 INFO - Running main action method: populate_webroot 17:56:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:56:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:56:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:56:44 INFO - '--tppagecycles', 17:56:44 INFO - '7'], 17:56:44 INFO - 'tests': ['tsvgm']}}, 17:56:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:56:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:56:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:56:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:56:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:56:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:56:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:44 INFO - 'talos_options': ['--disable-e10s'], 17:56:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:44 INFO - 'talos_options': ['--disable-e10s'], 17:56:44 INFO - 'tests': ['damp', 'tps']}, 17:56:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:44 INFO - 'tests': ['damp', 'tps']}, 17:56:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:56:44 INFO - 'tests': ['dromaeo_dom']}, 17:56:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:56:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:56:44 INFO - 'tests': ['basic_compositor_video']}, 17:56:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:56:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:56:44 INFO - 'tests': ['a11yr', 17:56:44 INFO - 'ts_paint', 17:56:44 INFO - 'tpaint', 17:56:44 INFO - 'sessionrestore', 17:56:44 INFO - 'sessionrestore_no_auto_restore', 17:56:44 INFO - 'tabpaint']}, 17:56:44 INFO - 'other-e10s': {'tests': ['a11yr', 17:56:44 INFO - 'ts_paint', 17:56:44 INFO - 'tpaint', 17:56:44 INFO - 'sessionrestore', 17:56:44 INFO - 'sessionrestore_no_auto_restore', 17:56:44 INFO - 'tabpaint']}, 17:56:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:56:44 INFO - 'ts_paint', 17:56:44 INFO - 'tpaint', 17:56:44 INFO - 'sessionrestore', 17:56:44 INFO - 'sessionrestore_no_auto_restore', 17:56:44 INFO - 'tabpaint']}, 17:56:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:56:44 INFO - 'ts_paint', 17:56:44 INFO - 'tpaint', 17:56:44 INFO - 'sessionrestore', 17:56:44 INFO - 'sessionrestore_no_auto_restore', 17:56:44 INFO - 'tabpaint']}, 17:56:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:56:44 INFO - 'tests': ['a11yr', 17:56:44 INFO - 'ts_paint', 17:56:44 INFO - 'tpaint', 17:56:44 INFO - 'sessionrestore', 17:56:44 INFO - 'sessionrestore_no_auto_restore', 17:56:44 INFO - 'tabpaint']}, 17:56:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:56:44 INFO - 'tests': ['a11yr', 17:56:44 INFO - 'ts_paint', 17:56:44 INFO - 'tpaint', 17:56:44 INFO - 'sessionrestore', 17:56:44 INFO - 'sessionrestore_no_auto_restore', 17:56:44 INFO - 'tabpaint']}, 17:56:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:56:44 INFO - 'tests': ['tsvgx', 17:56:44 INFO - 'tsvgr_opacity', 17:56:44 INFO - 'tart', 17:56:44 INFO - 'tscrollx', 17:56:44 INFO - 'cart']}, 17:56:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:56:44 INFO - 'tsvgr_opacity', 17:56:44 INFO - 'tart', 17:56:44 INFO - 'tscrollx', 17:56:44 INFO - 'cart']}, 17:56:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:44 INFO - 'talos_options': ['--disable-e10s'], 17:56:44 INFO - 'tests': ['tp5o']}, 17:56:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:44 INFO - 'tests': ['tp5o']}, 17:56:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:44 INFO - 'talos_options': ['--disable-e10s', 17:56:44 INFO - '--xperf_path', 17:56:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:44 INFO - 'tests': ['tp5n']}, 17:56:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:44 INFO - 'talos_options': ['--xperf_path', 17:56:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:44 INFO - 'tests': ['tp5n']}}, 17:56:44 INFO - 'talos.zip': {'path': '', 17:56:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:56:44 INFO - Running post-action listener: _resource_record_post_action 17:56:44 INFO - [mozharness: 2016-08-17 00:56:44.011462Z] Finished populate-webroot step (success) 17:56:44 INFO - [mozharness: 2016-08-17 00:56:44.011554Z] Running create-virtualenv step. 17:56:44 INFO - Running pre-action listener: _resource_record_pre_action 17:56:44 INFO - Running main action method: create_virtualenv 17:56:44 INFO - Creating virtualenv /builds/slave/test/build/venv 17:56:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:56:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:56:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:56:44 INFO - Using real prefix '/usr' 17:56:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:56:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:56:46 INFO - Installing pip.................done. 17:56:46 INFO - Return code: 0 17:56:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee687c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164d20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21660b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:56:46 INFO - Using env: {'DISPLAY': ':0', 17:56:46 INFO - 'HOME': '/home/cltbld', 17:56:46 INFO - 'LANG': 'en_US.UTF-8', 17:56:46 INFO - 'LANGUAGE': 'en_US:en', 17:56:46 INFO - 'LOGNAME': 'cltbld', 17:56:46 INFO - 'MAIL': '/var/mail/cltbld', 17:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:46 INFO - 'MOZ_NO_REMOTE': '1', 17:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:46 INFO - 'NO_EM_RESTART': '1', 17:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:46 INFO - 'PWD': '/builds/slave/test', 17:56:46 INFO - 'SHELL': '/bin/bash', 17:56:46 INFO - 'SHLVL': '1', 17:56:46 INFO - 'TERM': 'linux', 17:56:46 INFO - 'TMOUT': '86400', 17:56:46 INFO - 'USER': 'cltbld', 17:56:46 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 17:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:46 INFO - '_': '/tools/buildbot/bin/python'} 17:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:56:46 INFO - Cleaning up... 17:56:46 INFO - Return code: 0 17:56:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee687c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164d20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21660b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:56:46 INFO - Using env: {'DISPLAY': ':0', 17:56:46 INFO - 'HOME': '/home/cltbld', 17:56:46 INFO - 'LANG': 'en_US.UTF-8', 17:56:46 INFO - 'LANGUAGE': 'en_US:en', 17:56:46 INFO - 'LOGNAME': 'cltbld', 17:56:46 INFO - 'MAIL': '/var/mail/cltbld', 17:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:46 INFO - 'MOZ_NO_REMOTE': '1', 17:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:46 INFO - 'NO_EM_RESTART': '1', 17:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:46 INFO - 'PWD': '/builds/slave/test', 17:56:46 INFO - 'SHELL': '/bin/bash', 17:56:46 INFO - 'SHLVL': '1', 17:56:46 INFO - 'TERM': 'linux', 17:56:46 INFO - 'TMOUT': '86400', 17:56:46 INFO - 'USER': 'cltbld', 17:56:46 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 17:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:46 INFO - '_': '/tools/buildbot/bin/python'} 17:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:47 INFO - Downloading/unpacking psutil>=3.1.1 17:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:49 INFO - Installing collected packages: psutil 17:56:49 INFO - Running setup.py install for psutil 17:56:49 INFO - building 'psutil._psutil_linux' extension 17:56:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:56:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:56:49 INFO - building 'psutil._psutil_posix' extension 17:56:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:56:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:49 INFO - Successfully installed psutil 17:56:49 INFO - Cleaning up... 17:56:49 INFO - Return code: 0 17:56:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee687c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164d20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21660b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:56:49 INFO - Using env: {'DISPLAY': ':0', 17:56:49 INFO - 'HOME': '/home/cltbld', 17:56:49 INFO - 'LANG': 'en_US.UTF-8', 17:56:49 INFO - 'LANGUAGE': 'en_US:en', 17:56:49 INFO - 'LOGNAME': 'cltbld', 17:56:49 INFO - 'MAIL': '/var/mail/cltbld', 17:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:49 INFO - 'MOZ_NO_REMOTE': '1', 17:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:49 INFO - 'NO_EM_RESTART': '1', 17:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:49 INFO - 'PWD': '/builds/slave/test', 17:56:49 INFO - 'SHELL': '/bin/bash', 17:56:49 INFO - 'SHLVL': '1', 17:56:49 INFO - 'TERM': 'linux', 17:56:49 INFO - 'TMOUT': '86400', 17:56:49 INFO - 'USER': 'cltbld', 17:56:49 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 17:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:49 INFO - '_': '/tools/buildbot/bin/python'} 17:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:56:51 INFO - Installing collected packages: mozsystemmonitor 17:56:51 INFO - Running setup.py install for mozsystemmonitor 17:56:51 INFO - Successfully installed mozsystemmonitor 17:56:51 INFO - Cleaning up... 17:56:51 INFO - Return code: 0 17:56:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee687c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164d20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21660b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:56:51 INFO - Using env: {'DISPLAY': ':0', 17:56:51 INFO - 'HOME': '/home/cltbld', 17:56:51 INFO - 'LANG': 'en_US.UTF-8', 17:56:51 INFO - 'LANGUAGE': 'en_US:en', 17:56:51 INFO - 'LOGNAME': 'cltbld', 17:56:51 INFO - 'MAIL': '/var/mail/cltbld', 17:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:51 INFO - 'MOZ_NO_REMOTE': '1', 17:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:51 INFO - 'NO_EM_RESTART': '1', 17:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:51 INFO - 'PWD': '/builds/slave/test', 17:56:51 INFO - 'SHELL': '/bin/bash', 17:56:51 INFO - 'SHLVL': '1', 17:56:51 INFO - 'TERM': 'linux', 17:56:51 INFO - 'TMOUT': '86400', 17:56:51 INFO - 'USER': 'cltbld', 17:56:51 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 17:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:51 INFO - '_': '/tools/buildbot/bin/python'} 17:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:52 INFO - Downloading/unpacking jsonschema==2.5.1 17:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:56:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:54 INFO - Downloading functools32-3.2.3-2.tar.gz 17:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:56:54 INFO - warning: no files found matching '*.txt' 17:56:54 INFO - no previously-included directories found matching 'build' 17:56:54 INFO - no previously-included directories found matching 'dist' 17:56:54 INFO - no previously-included directories found matching '.git*' 17:56:54 INFO - Installing collected packages: jsonschema, functools32 17:56:54 INFO - Running setup.py install for functools32 17:56:54 INFO - warning: no files found matching '*.txt' 17:56:54 INFO - no previously-included directories found matching 'build' 17:56:54 INFO - no previously-included directories found matching 'dist' 17:56:54 INFO - no previously-included directories found matching '.git*' 17:56:54 INFO - Successfully installed jsonschema functools32 17:56:54 INFO - Cleaning up... 17:56:54 INFO - Return code: 0 17:56:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee687c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164d20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21660b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:56:54 INFO - Using env: {'DISPLAY': ':0', 17:56:54 INFO - 'HOME': '/home/cltbld', 17:56:54 INFO - 'LANG': 'en_US.UTF-8', 17:56:54 INFO - 'LANGUAGE': 'en_US:en', 17:56:54 INFO - 'LOGNAME': 'cltbld', 17:56:54 INFO - 'MAIL': '/var/mail/cltbld', 17:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:54 INFO - 'MOZ_NO_REMOTE': '1', 17:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:54 INFO - 'NO_EM_RESTART': '1', 17:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:54 INFO - 'PWD': '/builds/slave/test', 17:56:54 INFO - 'SHELL': '/bin/bash', 17:56:54 INFO - 'SHLVL': '1', 17:56:54 INFO - 'TERM': 'linux', 17:56:54 INFO - 'TMOUT': '86400', 17:56:54 INFO - 'USER': 'cltbld', 17:56:54 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 17:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:54 INFO - '_': '/tools/buildbot/bin/python'} 17:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:56:54 INFO - Cleaning up... 17:56:54 INFO - Return code: 0 17:56:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee687c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164d20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21660b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:56:54 INFO - Using env: {'DISPLAY': ':0', 17:56:54 INFO - 'HOME': '/home/cltbld', 17:56:54 INFO - 'LANG': 'en_US.UTF-8', 17:56:54 INFO - 'LANGUAGE': 'en_US:en', 17:56:54 INFO - 'LOGNAME': 'cltbld', 17:56:54 INFO - 'MAIL': '/var/mail/cltbld', 17:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:54 INFO - 'MOZ_NO_REMOTE': '1', 17:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:54 INFO - 'NO_EM_RESTART': '1', 17:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:54 INFO - 'PWD': '/builds/slave/test', 17:56:54 INFO - 'SHELL': '/bin/bash', 17:56:54 INFO - 'SHLVL': '1', 17:56:54 INFO - 'TERM': 'linux', 17:56:54 INFO - 'TMOUT': '86400', 17:56:54 INFO - 'USER': 'cltbld', 17:56:54 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 17:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:54 INFO - '_': '/tools/buildbot/bin/python'} 17:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:54 INFO - Downloading/unpacking blobuploader==1.2.4 17:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:56 INFO - Downloading blobuploader-1.2.4.tar.gz 17:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:56:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:56:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:57 INFO - Downloading docopt-0.6.1.tar.gz 17:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:56:57 INFO - Installing collected packages: blobuploader, requests, docopt 17:56:57 INFO - Running setup.py install for blobuploader 17:56:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:56:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:56:57 INFO - Running setup.py install for requests 17:56:57 INFO - Running setup.py install for docopt 17:56:58 INFO - Successfully installed blobuploader requests docopt 17:56:58 INFO - Cleaning up... 17:56:58 INFO - Return code: 0 17:56:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee687c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164d20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21660b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:56:58 INFO - Using env: {'DISPLAY': ':0', 17:56:58 INFO - 'HOME': '/home/cltbld', 17:56:58 INFO - 'LANG': 'en_US.UTF-8', 17:56:58 INFO - 'LANGUAGE': 'en_US:en', 17:56:58 INFO - 'LOGNAME': 'cltbld', 17:56:58 INFO - 'MAIL': '/var/mail/cltbld', 17:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:58 INFO - 'MOZ_NO_REMOTE': '1', 17:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:58 INFO - 'NO_EM_RESTART': '1', 17:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:58 INFO - 'PWD': '/builds/slave/test', 17:56:58 INFO - 'SHELL': '/bin/bash', 17:56:58 INFO - 'SHLVL': '1', 17:56:58 INFO - 'TERM': 'linux', 17:56:58 INFO - 'TMOUT': '86400', 17:56:58 INFO - 'USER': 'cltbld', 17:56:58 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 17:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:58 INFO - '_': '/tools/buildbot/bin/python'} 17:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:58 INFO - Running setup.py (path:/tmp/pip-hZXwxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:58 INFO - Running setup.py (path:/tmp/pip-U0BElF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:58 INFO - Running setup.py (path:/tmp/pip-4x0NYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:58 INFO - Running setup.py (path:/tmp/pip-owxzME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:58 INFO - Running setup.py (path:/tmp/pip-TTSKG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:58 INFO - Running setup.py (path:/tmp/pip-oozaNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:58 INFO - Running setup.py (path:/tmp/pip-DMZxB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:58 INFO - Running setup.py (path:/tmp/pip-s0pVd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:58 INFO - Running setup.py (path:/tmp/pip-M_Ej5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:58 INFO - Running setup.py (path:/tmp/pip-XGRUZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:59 INFO - Running setup.py (path:/tmp/pip-cLSPtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:59 INFO - Running setup.py (path:/tmp/pip-14_iEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:59 INFO - Running setup.py (path:/tmp/pip-oFQPnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:59 INFO - Running setup.py (path:/tmp/pip-VzSfJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:59 INFO - Running setup.py (path:/tmp/pip-i8EspX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:59 INFO - Running setup.py (path:/tmp/pip-xsq3qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:59 INFO - Running setup.py (path:/tmp/pip-tumFZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:56:59 INFO - Running setup.py install for manifestparser 17:56:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:56:59 INFO - Running setup.py install for mozcrash 17:56:59 INFO - Running setup.py install for mozdebug 17:56:59 INFO - Running setup.py install for mozdevice 17:56:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:56:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:56:59 INFO - Running setup.py install for mozfile 17:57:00 INFO - Running setup.py install for mozhttpd 17:57:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:57:00 INFO - Running setup.py install for mozinfo 17:57:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:57:00 INFO - Running setup.py install for mozInstall 17:57:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:57:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:57:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:57:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:57:00 INFO - Running setup.py install for mozleak 17:57:00 INFO - Running setup.py install for mozlog 17:57:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:57:00 INFO - Running setup.py install for moznetwork 17:57:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:57:00 INFO - Running setup.py install for mozprocess 17:57:00 INFO - Running setup.py install for mozprofile 17:57:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:57:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:57:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:57:00 INFO - Running setup.py install for mozrunner 17:57:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:57:00 INFO - Running setup.py install for mozscreenshot 17:57:01 INFO - Running setup.py install for moztest 17:57:01 INFO - Running setup.py install for mozversion 17:57:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:57:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:57:01 INFO - Cleaning up... 17:57:01 INFO - Return code: 0 17:57:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee687c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164d20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21660b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:57:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:57:01 INFO - Using env: {'DISPLAY': ':0', 17:57:01 INFO - 'HOME': '/home/cltbld', 17:57:01 INFO - 'LANG': 'en_US.UTF-8', 17:57:01 INFO - 'LANGUAGE': 'en_US:en', 17:57:01 INFO - 'LOGNAME': 'cltbld', 17:57:01 INFO - 'MAIL': '/var/mail/cltbld', 17:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:01 INFO - 'MOZ_NO_REMOTE': '1', 17:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:01 INFO - 'NO_EM_RESTART': '1', 17:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:01 INFO - 'PWD': '/builds/slave/test', 17:57:01 INFO - 'SHELL': '/bin/bash', 17:57:01 INFO - 'SHLVL': '1', 17:57:01 INFO - 'TERM': 'linux', 17:57:01 INFO - 'TMOUT': '86400', 17:57:01 INFO - 'USER': 'cltbld', 17:57:01 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 17:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:01 INFO - '_': '/tools/buildbot/bin/python'} 17:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:57:01 INFO - Running setup.py (path:/tmp/pip-3Vf2j_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:57:01 INFO - Running setup.py (path:/tmp/pip-LWKMXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:57:01 INFO - Running setup.py (path:/tmp/pip-1RpdIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:57:01 INFO - Running setup.py (path:/tmp/pip-ZWaR39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:57:01 INFO - Running setup.py (path:/tmp/pip-RkiHy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:57:01 INFO - Running setup.py (path:/tmp/pip-AFHg35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:57:01 INFO - Running setup.py (path:/tmp/pip-TTZuE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:57:02 INFO - Running setup.py (path:/tmp/pip-qS7BAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:57:02 INFO - Running setup.py (path:/tmp/pip-FyLbtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:57:02 INFO - Running setup.py (path:/tmp/pip-QBXfVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:57:02 INFO - Running setup.py (path:/tmp/pip-jKbJIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:57:02 INFO - Running setup.py (path:/tmp/pip-MK16bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:57:02 INFO - Running setup.py (path:/tmp/pip-oj8pPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:57:02 INFO - Running setup.py (path:/tmp/pip-7goxGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:02 INFO - Running setup.py (path:/tmp/pip-UJcnH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:57:02 INFO - Running setup.py (path:/tmp/pip-KKvEBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:57:02 INFO - Running setup.py (path:/tmp/pip-ad6tgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:57:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:04 INFO - Downloading blessings-1.6.tar.gz 17:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:57:04 INFO - Installing collected packages: blessings 17:57:04 INFO - Running setup.py install for blessings 17:57:04 INFO - Successfully installed blessings 17:57:04 INFO - Cleaning up... 17:57:04 INFO - Return code: 0 17:57:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:57:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:57:05 INFO - Reading from file tmpfile_stdout 17:57:05 INFO - Current package versions: 17:57:05 INFO - argparse == 1.2.1 17:57:05 INFO - blessings == 1.6 17:57:05 INFO - blobuploader == 1.2.4 17:57:05 INFO - docopt == 0.6.1 17:57:05 INFO - functools32 == 3.2.3-2 17:57:05 INFO - jsonschema == 2.5.1 17:57:05 INFO - manifestparser == 1.1 17:57:05 INFO - mozInstall == 1.12 17:57:05 INFO - mozcrash == 0.17 17:57:05 INFO - mozdebug == 0.1 17:57:05 INFO - mozdevice == 0.48 17:57:05 INFO - mozfile == 1.2 17:57:05 INFO - mozhttpd == 0.7 17:57:05 INFO - mozinfo == 0.9 17:57:05 INFO - mozleak == 0.1 17:57:05 INFO - mozlog == 3.3 17:57:05 INFO - moznetwork == 0.27 17:57:05 INFO - mozprocess == 0.23 17:57:05 INFO - mozprofile == 0.28 17:57:05 INFO - mozrunner == 6.12 17:57:05 INFO - mozscreenshot == 0.1 17:57:05 INFO - mozsystemmonitor == 0.3 17:57:05 INFO - moztest == 0.7 17:57:05 INFO - mozversion == 1.4 17:57:05 INFO - psutil == 3.1.1 17:57:05 INFO - requests == 1.2.3 17:57:05 INFO - wsgiref == 0.1.2 17:57:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee687c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164d20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21660b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:57:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:57:05 INFO - Using env: {'DISPLAY': ':0', 17:57:05 INFO - 'HOME': '/home/cltbld', 17:57:05 INFO - 'LANG': 'en_US.UTF-8', 17:57:05 INFO - 'LANGUAGE': 'en_US:en', 17:57:05 INFO - 'LOGNAME': 'cltbld', 17:57:05 INFO - 'MAIL': '/var/mail/cltbld', 17:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:05 INFO - 'MOZ_NO_REMOTE': '1', 17:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:05 INFO - 'NO_EM_RESTART': '1', 17:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:05 INFO - 'PWD': '/builds/slave/test', 17:57:05 INFO - 'SHELL': '/bin/bash', 17:57:05 INFO - 'SHLVL': '1', 17:57:05 INFO - 'TERM': 'linux', 17:57:05 INFO - 'TMOUT': '86400', 17:57:05 INFO - 'USER': 'cltbld', 17:57:05 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 17:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:05 INFO - '_': '/tools/buildbot/bin/python'} 17:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:57:05 INFO - Cleaning up... 17:57:05 INFO - Return code: 0 17:57:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee687c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164d20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21660b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:57:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:57:05 INFO - Using env: {'DISPLAY': ':0', 17:57:05 INFO - 'HOME': '/home/cltbld', 17:57:05 INFO - 'LANG': 'en_US.UTF-8', 17:57:05 INFO - 'LANGUAGE': 'en_US:en', 17:57:05 INFO - 'LOGNAME': 'cltbld', 17:57:05 INFO - 'MAIL': '/var/mail/cltbld', 17:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:05 INFO - 'MOZ_NO_REMOTE': '1', 17:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:05 INFO - 'NO_EM_RESTART': '1', 17:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:05 INFO - 'PWD': '/builds/slave/test', 17:57:05 INFO - 'SHELL': '/bin/bash', 17:57:05 INFO - 'SHLVL': '1', 17:57:05 INFO - 'TERM': 'linux', 17:57:05 INFO - 'TMOUT': '86400', 17:57:05 INFO - 'USER': 'cltbld', 17:57:05 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 17:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:05 INFO - '_': '/tools/buildbot/bin/python'} 17:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:57:05 INFO - Cleaning up... 17:57:05 INFO - Return code: 0 17:57:05 INFO - Running post-action listener: _resource_record_post_action 17:57:05 INFO - Running post-action listener: _start_resource_monitoring 17:57:05 INFO - Starting resource monitoring. 17:57:05 INFO - [mozharness: 2016-08-17 00:57:05.558449Z] Finished create-virtualenv step (success) 17:57:05 INFO - [mozharness: 2016-08-17 00:57:05.558918Z] Running install step. 17:57:05 INFO - Running pre-action listener: _resource_record_pre_action 17:57:05 INFO - Running main action method: install 17:57:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:57:05 INFO - Reading from file tmpfile_stdout 17:57:05 INFO - Detecting whether we're running mozinstall >=1.0... 17:57:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:57:05 INFO - Reading from file tmpfile_stdout 17:57:05 INFO - Output received: 17:57:05 INFO - Usage: mozinstall [options] installer 17:57:05 INFO - Options: 17:57:05 INFO - -h, --help show this help message and exit 17:57:05 INFO - -d DEST, --destination=DEST 17:57:05 INFO - Directory to install application into. [default: 17:57:05 INFO - "/builds/slave/test"] 17:57:05 INFO - --app=APP Application being installed. [default: firefox] 17:57:05 INFO - mkdir: /builds/slave/test/build/application 17:57:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:57:21 INFO - Reading from file tmpfile_stdout 17:57:21 INFO - Output received: 17:57:21 INFO - /builds/slave/test/build/application/firefox/firefox 17:57:21 INFO - Running post-action listener: _resource_record_post_action 17:57:21 INFO - [mozharness: 2016-08-17 00:57:21.846893Z] Finished install step (success) 17:57:21 INFO - [mozharness: 2016-08-17 00:57:21.847140Z] Running run-tests step. 17:57:21 INFO - Running pre-action listener: _resource_record_pre_action 17:57:21 INFO - Running main action method: run_tests 17:57:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:57:21 INFO - Python 2.7.3 17:57:21 INFO - Return code: 0 17:57:21 INFO - grabbing minidump binary from tooltool 17:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164d20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21660b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:57:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:57:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:57:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:57:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:57:21 INFO - Return code: 0 17:57:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:57:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:57:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:57:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:57:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:57:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:57:21 INFO - Using env: {'DISPLAY': ':0', 17:57:21 INFO - 'HOME': '/home/cltbld', 17:57:21 INFO - 'LANG': 'en_US.UTF-8', 17:57:21 INFO - 'LANGUAGE': 'en_US:en', 17:57:21 INFO - 'LOGNAME': 'cltbld', 17:57:21 INFO - 'MAIL': '/var/mail/cltbld', 17:57:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:57:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:21 INFO - 'MOZ_NO_REMOTE': '1', 17:57:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:21 INFO - 'NO_EM_RESTART': '1', 17:57:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:21 INFO - 'PWD': '/builds/slave/test', 17:57:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:57:21 INFO - 'SHELL': '/bin/bash', 17:57:21 INFO - 'SHLVL': '1', 17:57:21 INFO - 'TERM': 'linux', 17:57:21 INFO - 'TMOUT': '86400', 17:57:21 INFO - 'USER': 'cltbld', 17:57:21 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974', 17:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:21 INFO - '_': '/tools/buildbot/bin/python'} 17:57:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:57:22 INFO - mozversion application_buildid: 20160816162614 17:57:22 INFO - mozversion application_changeset: 4b48ad68a5945476857c08a9f67487fbdae51582 17:57:22 INFO - mozversion application_display_name: Nightly 17:57:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:57:22 INFO - mozversion application_name: Firefox 17:57:22 INFO - mozversion application_remotingname: firefox 17:57:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:57:22 INFO - mozversion application_vendor: Mozilla 17:57:22 INFO - mozversion application_version: 51.0a1 17:57:22 INFO - mozversion platform_buildid: 20160816162614 17:57:22 INFO - mozversion platform_changeset: 4b48ad68a5945476857c08a9f67487fbdae51582 17:57:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:57:22 INFO - mozversion platform_version: 51.0a1 17:57:22 INFO - using testdate: 1471395442 17:57:22 INFO - actual date: 1471395442 17:57:22 INFO - starting webserver on 'localhost:43742' 17:57:22 INFO - SUITE-START | Running 2 tests 17:57:22 INFO - TEST-START | dromaeo_css 17:57:22 INFO - operating with platform_type : linux_ 17:57:22 INFO - Initialising browser for dromaeo_css test... 17:57:22 INFO - TEST-INFO | started process 27273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmyKMyt/profile http://localhost:43742/getInfo.html) 17:57:26 INFO - PROCESS | 27273 | __metrics Screen width/height:1600/1200 17:57:26 INFO - PROCESS | 27273 | colorDepth:24 17:57:26 INFO - PROCESS | 27273 | Browser inner width/height: 1024/697 17:57:26 INFO - PROCESS | 27273 | __metrics 17:57:27 INFO - PROCESS | 27273 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:57:27 INFO - PROCESS | 27273 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:57:27 INFO - PROCESS | 27273 | console.error: PushService: 17:57:27 INFO - PROCESS | 27273 | stateChangeProcessEnqueue: Error transitioning state 17:57:27 INFO - PROCESS | 27273 | UnknownError 17:57:28 INFO - TEST-INFO | 27273: exit 0 17:57:28 INFO - Browser initialized. 17:57:28 INFO - Running cycle 1/1 for dromaeo_css test... 17:57:28 INFO - TEST-INFO | started process 27352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmyKMyt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:57:40 INFO - PROCESS | 27352 | RSS: Main: 155389952 17:57:40 INFO - PROCESS | 27352 | 17:58:31 INFO - PROCESS | 27352 | 1471395511353 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:00:44 INFO - PROCESS | 27352 | Cycle 1(1): loaded http://localhost:43742/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43742/tests/dromaeo/cssquery-ext.html) 18:00:45 INFO - PROCESS | 27352 | RSS: Main: 224088064 18:00:45 INFO - PROCESS | 27352 | 18:03:48 INFO - PROCESS | 27352 | Cycle 1(1): loaded http://localhost:43742/tests/dromaeo/cssquery-ext.html (next: http://localhost:43742/tests/dromaeo/cssquery-jquery.html) 18:03:49 INFO - PROCESS | 27352 | RSS: Main: 242364416 18:03:49 INFO - PROCESS | 27352 | 18:06:51 INFO - PROCESS | 27352 | Cycle 1(1): loaded http://localhost:43742/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43742/tests/dromaeo/cssquery-mootools.html) 18:06:51 INFO - PROCESS | 27352 | RSS: Main: 187105280 18:06:51 INFO - PROCESS | 27352 | 18:09:54 INFO - PROCESS | 27352 | Cycle 1(1): loaded http://localhost:43742/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43742/tests/dromaeo/cssquery-prototype.html) 18:09:54 INFO - PROCESS | 27352 | RSS: Main: 192249856 18:09:54 INFO - PROCESS | 27352 | 18:12:57 INFO - PROCESS | 27352 | Cycle 1(1): loaded http://localhost:43742/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43742/tests/dromaeo/cssquery-yui.html) 18:12:58 INFO - PROCESS | 27352 | RSS: Main: 188370944 18:12:58 INFO - PROCESS | 27352 | 18:16:01 INFO - PROCESS | 27352 | Cycle 1(1): loaded http://localhost:43742/tests/dromaeo/cssquery-yui.html (next: http://localhost:43742/tests/dromaeo/cssquery-dojo.html) 18:16:01 INFO - PROCESS | 27352 | RSS: Main: 273367040 18:16:01 INFO - PROCESS | 27352 | 18:16:01 INFO - PROCESS | 27352 | __start_tp_report 18:16:01 INFO - PROCESS | 27352 | _x_x_mozilla_page_load 18:16:01 INFO - PROCESS | 27352 | _x_x_mozilla_page_load_details 18:16:01 INFO - PROCESS | 27352 | |i|pagename|runs| 18:16:01 INFO - PROCESS | 27352 | |0;dojo.html;2636.406808468095;2653.6417583626203;2672.799540034497;2689.811713180077;2691.5020721166584;4769.260764581487;4810.494898035704;4819.951800481994;4859.149648811462;4863.221884498476;4717.882052948678;4807.206810876201;4874.6831455955335;4882.340883980662;4900.950990490094;4401.779911004453;4467.7542735149555;4472.508024117345;4505.93241101383;4516.570925762064;4467.664925130612;4504.279315309551;4504.707194032378;4521.299198624219;4568.200564901145;4565.429321334816;4587.334836448713;4596.057808149338;4605.148047611203;4607.07858428314;4374.212641724488;4380.693351465398;4419.049904270565;4500.774961251957;4554.612857907082;4351.912961740747;4357.106793107406;4369.58488943553;4377.868663940055;4447.799849006802;4832.9758351208375;4862.07620552094;4878.317035615017;4882.292067650206;4892.730899800509;4983.8504844854715;5039.445660977326;5153.742312884378;5204.739763011872;5213.661112027706;5099.87250318745;5186.7925282988635;5188.273641690166;5191.662541934762;5196.662216955886;4781.784819683123;4822.373091498082;4830.275458681155;4831.0096430231715;4839.177339852234;5155.432902380735;5217.921731174036;5278.155495120763;5294.073537130987;5298.97350513245;5076.060928728123;5135.845924622267;5140.794368225229;5143.71709555978;5144.948550514447;5179.404368497671;5190.636655434083;5192.3769147702515;5193.662411943287;5227.085260079471;4960.90078198434;5071.695698258116;5119.769610367543;5129.743512824419;5170.844874653766;5131.820386286462;5148.768305426265;5155.329807125125;5189.558887494605;5206.817761378334;4357.237483440385;4361.781910904506;4363.52001279859;4390.780460976938;4400.075984043323;3754.1740817020213;3761.2853557824474;3762.680172185395;3803.980980095137;3837.9808100959317;4415.249407600716;4419.867403977886;4428.291473364311;4482.8655140345845;4490.3040028795585;5215.295935048795;5227.372715274116;5228.55557277628;5235.633505654568;5280.207968804633;4297.613214810682;4336.501302350207;4439.089986552749;4451.821927122944;4492.281235002384;4567.1550763108935;4593.127305811885;4608.677392582554;4648.395708557933;4663.766811659403;4838.879028024327;4851.781669824937;4851.95148048515;4856.077345304381;4905.484924083063;5054.115529782347;5082.8475145744205;5126.359205099363;5167.1474206755465;5212.50481204285;4810.855674329776;4869.415670119608;4887.731174785279;4904.950950490449;4910.21436570147;5076.949230507796;5077.7968881245815;5094.465081166424;5094.541491265803;5127.5897928166405;4987.9251811223585;5142.922856157086;5156.793728250828;5157.6647517911215;5163.793448262178;4977.925331120108;5047;5048.5203905628905;5109.8978020438635;5115.744212789271;5029.295898574275;5035.798568057383;5038.622103342191;5039.067772462106;5110.565601923878;4960.181570040902;4965.652404331662;5010.323606313247;5012.072766538202;5046.924296135488;4953.826616068564;4964.230544265644;5008.248762685626;5014;5089.083964886356;4868.853934381974;4893.877653058702;4909.5090490950615;4914.041761856403;4930.383702037246 18:16:01 INFO - PROCESS | 27352 | |1;ext.html;544.0397698062918;566.3373852592466;569.1235497334104;571.1775043936733;572.8796952639946;28887.133385998426;31516.527252091237;31588.842055789748;31611.525827112582;31627.367452650935;31553;39905.20189596206;40880.38679419811;41323.79338103313;44601.33098003524;7460.36586890115;7557.886631700529;7566.697332106709;7574.280443357872;7574.886376704354;7609.505382150171;7633.694652213905;7682.347000504964;7682.923170768277;7693.038370203724;7675.424343174284;7707.383409327241;7707.537547747125;7712.113106992683;7713.614319284014;7663.655135518887;7681.155072941972;7715.074191097048;7718.575478348688;7719.421043421766;7581.886271705929;7604;7635.541867487968;7640.885386719204;7651.043619547557;37968.62031379678;38215.426768598496;38227.80886095552;38230.617693822984;38273.425898611546;2957.600723902267;3143.921401964946;3340.28183940454;3361.8991430257133;3414.5902491701154;28242.15273541797;28452.28869278264;28522.572161417596;28590.428191436054;29790.85104574485;3196.7762256642045;3243.189202699325;3269.1500209945348;3340.4822252550653;3378.6959173674486;230447;230554;231060;232865;233154;27939.44121117607;28621.71378286232;52425.73787131116;52785.7360713194;52845;33118.834405827816;33233.66766332306;33532.83233583817;33536.664633353845;33573.66426335705;12089.274643521418;12298.508059677692;12314.076444266715;12326.691832704255;12331.815022774666;9532.761680958032;9598.568064437117;9618.663346782829;9623.133917947418;9633.710988670211;7734.883976740353;7833.921660783433;7862.72480463181;7898.210178982055;7930.44486885924;3127.5465057566526;3133.1697100268448;3134.7492200623897;3136.81179129253;3180.6501284858646;811.2820154163608;827.8592639251342;873.8296032273646;938.5354249646468;999.6551189839639;25956;27860.16419507418;27992;28008.159755207376;28285.29286767806;953.8998405167496;954.6944977607099;972.2125078686287;1008.621766837436;1017.1710056304237;14176.362063707158;14608.707825843423;14830.70338593222;14915.403383864741;15273.541793746206;370991;373038;373447;373718;375211;48853.26720099201;49366;49426.75286623544;49488.50511494839;49498;1097.6981330134117;1126.3354620773782;1157.2304417562395;1168.4391492083678;1195.8804119588146;25843;28838.567421488275;29641.407171856874;29669.85165074161;29882.402351952405;41786.79106604569;42237.78881105575;42366;42378.364324535774;42411;284451;285484;286007;286010;286047;22165.55668886581;22915.541689166457;24497.387565311008;25574.61638075393;25656.743432565436;41399.7930010348;41401.37897931594;41677.374839376826;42243.1551368977;42453.363199551415;35369.82315088408;35738.8213058933;35861.64138358583;36087;36397.63602364049;34635.65364346324;35629.465558016134;36080.63919360773;36616.81691591525;36819.63180368162;35440.46839297361;35546;36366.818165909004;36370.27259454849;36854.63145368512;30948;33523;33600;33661.32677346488;33699.49450758191;25030.874845625654;25410.967122629776;25430.745692543576;25607.23178304654;25971.48057038811 18:16:01 INFO - PROCESS | 27352 | |2;jquery.html;358.1708345180906;369.43476480984094;373.1343283582089;382.269864558693;382.9712771542135;16478.588035299108;17173.227204775783;17433.738493922585;17491.212895419703;17618.20718067687;15345.69308613827;15950.202489875488;15981.520554383358;16069.116198609072;16103.194840257998;4794.9520504794855;5046.899062018758;5047.167217409123;5049.48515445365;5050.7979680812905;3705.407134858423;4949.7772600233075;5679.7160141992945;5948.107783832438;5962.25471816023;5925.051991681332;5985.281766188064;5987.970060149693;5988.101784732282;5989.191459153002;5716.085426331788;5886.234789477383;5896.528277737771;5906.763729450817;5912.3496415394275;5058.392992840846;5118.658448331772;5184.807494276338;5191.091558977164;5192.454792246797;18907.338243161423;19913;20800.895995519924;21100.894495527577;21123.894380528;1947.4255094747084;2031.6343058249508;2087.9164833406644;2413.095089341497;2498.675172227599;9373.765655858659;9396.295277854188;9504.857427138599;9556.23550115989;9801.558929848174;1763.2682436788718;1776.564741638294;1812.5831058856536;1812.7824661040759;1821.4990877508658;65692;66816;69029.65485172592;69899;71128;9948;10025.298229124037;10242.436665983443;10298.845517317246;10320.43237621938;14013.439462421593;14016.369263383172;14018.929905350407;14033.1580105194;14055.508057217949;6616.636085015274;6732.124823772878;6762.154730658668;6953.165620125617;6959.598938366255;6289.811305660837;6308.053791931247;6318.684065796784;6386;6569.67151642416;4336.566343365638;4391.494978077562;4397.01067259864;4420.381146639473;4551.13528429604;1708.2910592104386;1749.5713550180287;1757.2970811675432;1833.758459006464;1889.4331700489797;790.6481615681082;823.1357075071152;888.6800751729372;891.8439273127307;918.5774543709834;16238.837611623969;16397.83602163987;16658.16709164537;16890.662186756195;17052.2326495308;799.0571126071292;809.4333966223667;817.3420396580691;845.3913182508584;846.1158089796178;8327.708530201535;9671.661491847752;9837.508124593742;9843.753906152404;9906.504674766233;372175;375505;383139;385097;385916;74224.59786590225;79460;79674.99999999884;80710;82419;781.7107670162077;803.6704950970075;850.46420754924;866.6923242248911;871.930245580352;14987.850121498646;15402.768958465856;16264.756028659816;16300.42948496797;16458.177091145633;37427.625723742414;37919.81040094782;37960.43059354167;38393;38879.222415552096;49483.75258123686;50120.99758004893;50349.24476132934;50480;51199.48800512096;10397.84403233937;10407.843882341922;10547.736306592396;10654;11059.668209953714;12355;12432.316222607844;12638.810417843555;12769.680757981125;12857.549985750455;10159.796804064024;10342;10947.307400152036;11077.390743509184;11232.494537745657;11194.272372295774;11228.66314010581;11234.101271898066;11384.430778460877;11567.710807229887;11227.21409501327;11294.322340659586;11557.82663260035;11768.352740599006;11783.880531349509;10391.181543229754;10537.52581133866;10873.07578855806;10910.23628346008;11058;10996.505157268102;11036.227464077438;11158.497867595815;11182.72043198894;11597.710057248636 18:16:01 INFO - PROCESS | 27352 | |3;mootools.html;1341.5371696764612;1357.7148798752262;1434.5767998440458;1606.1808477676382;1638.8443097905695;7409.777706668802;7958.204179582039;7978.640961156754;7998.92001079989;8014.5992700364895;6670.76652317169;6976.860462790741;7435.516691415054;7717;7785.844283114348;2204.1073365287043;2231.6987206727126;2232.2521955145044;2233.7542870284256;2235.1282999630157;2173.152470536484;2185.115028413487;2214.9778502215013;2220.222921977311;2221.178164079293;2170.717806685129;2171.2183613898983;2176.967345489819;2178.0743184146672;2209.171560664751;2150.2796563151364;2156.6657168138886;2157.600843843894;2161.1247444784885;2162.4053385319007;2152.2359562355296;2177.69512268281;2183.552371763785;2183.759786423492;2187.201671389947;7923.445358824884;7961.522308661499;7970.800729981739;7995.6801727930815;8006.399520035962;4392.780360981938;4454.331850222493;4528.343390208434;4536.818527258905;4538.387317712132;2961.185673939662;3047.0554128220324;3116.1274843043984;3116.7974081684843;3124.297033167542;926.249737712455;983.1348413396237;988.6786794291812;990.3216296836617;996.4021587047786;10846;10847.67456976292;10865.239433239676;10867.673969780999;10869.619563315246;3954.762714237155;4180.414741936132;4254.680898932531;4391.1217756448195;4395.890102747393;9244.768880778034;9246.445213287225;9246.768830779285;9254.028327025566;9277.907220927704;4503.054358584668;4509.88725281864;4526.936170000047;4534.614557762561;4535.659825513099;3521.3485505181625;3953.1303113315025;4008.8596899108975;4024.9798751006642;4095.406166105898;3615.1323682316056;3644.3986742187244;3753.0992561784974;3753.305638456894;3756.0609847538117;1194.4027986006997;1203.500547272872;1214.4656351205442;1218.3542722357165;1230.4278510492663;710.3039021758706;820.156973073999;844.6705784743955;847.1486156412766;848.1476116502876;5020.7740651670765;5185.688858668492;5268.209768534751;5335.973320133375;5389.299391079135;398.1797497155868;411.4959175010588;413.1138707472515;416.26736942980574;419.1805021183579;3607.3867442534834;3619.2399596085115;3620.2035552178477;3675.889723308305;3744.6068162842507;9014.954925225333;9569.89946156187;9605.231581473465;9609.807803843883;9611.855822162674;9267.25861931044;9425.151736343762;9483.383580067273;9497;9511.66709165176;7257.8548429031125;7270.418366530665;7343.522671026473;7361.153467351323;7368.447366447431;4848.151573474698;4856.295837103671;4868.342773725643;4931.704097754003;5080.364954380702;8514.318854491501;8732.60703268367;8839.381243312906;8841.071687472722;8909.955450222707;8769.824603507766;8868.423552469068;8907.064758200295;8981.82036359256;8984.91015089867;6575.80272591823;6631.734730610721;6678;6734.326567343226;6809.012693159563;7358.889616655862;7440.144383395978;7452.143003554444;7459.291367320096;7465.06686664167;6483.092367068709;6508.837279067871;6513.2835388108215;6577.440917522064;6831.726730930707;6455.354464553507;6499.38255865692;6662.267150613526;6694.531382803157;6797.25230224665;6045.969770151121;6139.6009259398;6142.385761423822;6145.9692701536205;6150.846228844314;4187.392828039978;4452.732836029849;4487.7307361557105;4582.358469814162;4604.953950460453;4490.326451032241;4499.5275496072445;4524.298733696282;4663.417072865892;4788.209945358977 18:16:01 INFO - PROCESS | 27352 | |4;prototype.html;300.8375477242289;306.56161688785045;309.07740394921154;313.07642454758457;315.7710659771664;4823.13183626947;4846.74626298771;4856.198727210015;4862.708237505753;4886.438059623144;4786.473487916326;4791.592714619262;4810.436608102364;4826.855194344175;4828.5412885775795;3623.202895363016;3734.3838266685966;3746.3256613809504;3800.8289626966716;3803.1823158021157;3795.8861234162882;3797.829097690597;3819.694424446038;3831.329517334469;3843.4427008083812;3757.755745876509;3761.153740408414;3770.359038963383;3783.924321513568;3806.9428958565645;3581.6776490115885;3649.8540058397634;3745.325841348556;3767.472553842464;3769.9067270491523;3342.4819153031317;3345.7955136150968;3346.657339862082;3354.194993201638;3354.3626710924846;4636.559526844944;4650.7442090685;4655.324083329999;4657.557532034485;4694.36626055485;4162.771047592381;4288.957110428918;4289.142171565668;4299.634531064863;4307.590778876001;4915.262710593403;4951.62862785289;4952.232403977389;4986.376702912136;5031.647784655075;3627.619099994489;3645.4714066460215;3651.6165802590613;3656.568382025976;3668.7248456365614;5029.446760856339;5231.163013917793;5242.344706911636;5251.68489890604;5283.55089817366;3652.2695460907926;3701.5373078365205;3702.296563652951;3702.9446607716673;3721.3115573618966;3777.527809023872;3778.301014312361;3791.4881490998364;3800.638939300762;3806.4861243731743;4298.527162012176;4300.89247768802;4316.1583491219535;4316.892077698019;4321.459817522809;4798.712077275305;4995.850124496271;5001.124803159432;5009.547231302954;5068.350787433043;1305.0799186573443;1318.775808112623;1318.81965640751;1320.2540564581172;1324.4900713225477;829.6930135849653;860.1957170045902;860.2086080805674;875.2123089219754;875.60160127142;4312.180685669713;4425.247707889666;4429.667774916894;4437.689361744647;4455.888602784891;5116.951025039933;5122.974385128051;5157.974210128926;5171;5176.818811341585;4417.763026352626;4423.137488189772;4442.911141777146;4468.302045222795;4478.081993191388;2616.5944278636844;2742.684591272029;2752.6008728734223;2752.6146339512484;2755.9035433759723;4883.291922671193;4895.265710143507;4903.681260718114;4916.164252077084;4923.276853101457;5055.823046193365;5308.362996440452;5313.681179129265;5328.706921119298;5330.840074797762;4886.438059623118;4916.508349165055;4916.754162291871;4946.802127914915;4949.28235405857;5183.714895680774;5188.922166167435;5222.6083043771105;5279.093470831634;5279.759256574625;4855.854324370274;5092.337996060489;5157.303763991813;5169.7673604687125;5170.689758614495;4872.220444728827;4890;4906.215005599087;4909.828156014522;4936.420345489409;3744.7378683491893;3777.0934975606206;3809.542854857435;3810.5808361079703;3820.255050265283;5024.296598476143;5090.745462726923;5140;5174.120399532013;5176.334187893162;4925.408950925912;4932.975335123301;4935.654504184817;4943.2585112233455;4981.285199566318;4921.704697718148;4928.507149285043;4959.156943319572;5001.4998500149695;5026.396832380138;4691.7184968901975;4879.73161476108;4915.279652121729;4923.483034281349;4943.714634195063;4851.58761505276;4926.433460152129;4946.950530494649;4975.950240497548;5027.547520723152;4943.184374578154;4947.233178857283;4966.279889415942;4966.478519755374;5001.824936127218 18:16:01 INFO - PROCESS | 27352 | |5;yui.html;619.4579742725118;632.7310892870529;645.6578013652766;730.3025610541933;732.8204589875478;12087.75824483511;12678.746425071517;12722.23666580006;12724.809127863078;12725.809112863302;13369.732605347886;13435.32823358833;13451.66370840727;13510.729785404286;13554.051216414855;616.7101462312706;736.661135877497;749.6064566102785;767.2710924621604;768.0629631849163;771.6103367799253;775.2363921537282;777.6228529163351;778.0857492446381;778.2101167315179;819.1521774962914;819.5082950229844;820.3109388113983;820.4748960665149;821.0557858462756;648.691871361102;667.5293917787997;669.9028640847099;671.318611609217;811.6063709101081;580.9796657117023;597.3399393670019;598.0162632469563;598.4344794169511;601.8465291350722;13240.86759132406;13252.20486770797;13272.535461258905;13276.402561884739;13310.068295219338;12599;12870.742585148244;13183.86816131836;13382;13685.589432317047;11536.365499897502;11954.222975506564;12096.939515302367;12309.93845030769;12556.967080140728;4121.505419349667;4178.895527611804;4287.078278170208;4342.131573685276;4342.848000320006;64895.70208595849;65123;65165.67417162884;65245.347546524405;65936.3406365935;10654;10834.891651083388;10876.728081798019;10927.836082458769;10954.178436617285;19455.22179112848;19520.80479195218;19531.902340488206;19545.413637590897;19622.411327660193;6608.107905432801;6678.632675202911;6776.559523630948;6888.41448476885;6974.616396098162;3577.338192434408;3650.233450975325;3684.299983003221;3704.518412606344;3764.8682296119505;2763.7374449427675;2831.419558990402;2865.5415133578526;2889.6821349651523;2893.594896714462;479.7769037397627;493.40298239131056;496.33491121896833;512.078259133558;519.714157213531;486.5985561911437;519.498683770156;534.5242733966695;555.4390066033335;559.0384538593612;6838.281980392087;6938.444924406035;7178.461615378763;7255.8911616325795;8254.669813207405;563.7857614106696;584.6755050946765;590.7991282963812;596.4631831351818;600.1747597054051;3610.909727256787;3813.2373525294497;3833.386658134685;3876.3991581304945;3930.6069393060466;105746;107882;108438;110096;110416.4479177599;49651.25523117156;71915;85411;86185.56907215423;86619;48513.272300915516;61385;80348;80899.59550202212;81848;7268.41852651776;7550.735724249625;7575.583342915972;7738.2261773822165;7754.92245077542;44819;45215;45688.31467527923;46981.295280570135;46985;65172.674136629015;69101.30898690948;69199.30800691928;70384;70802.29197707957;9451.102145296185;9477.715668529956;9485.525723713925;9787.902120978699;9934.701958941243;10535.42055186972;10695.94652026735;10704.946475267574;11499.080073593925;11512.481938312629;9122.680706175252;9127.161709279251;9446.669366572138;9450.102240287162;9470.621175152917;9855.162311203341;9989.750256243651;10087.89033206332;10263.332883362558;10290.12533934624;9559.330846840932;9715.465649389069;9767.609295628095;10086.697399078039;10187.541560629641;8408.495490270603;8455.577221138796;8679.132086791271;8877.201051905102;8889.911100888909;8094.190580941859;8470.017614682522;8534.530600817016;8548.871766923625;8753.168448997336 18:16:01 INFO - PROCESS | 27352 | __end_tp_report 18:16:01 INFO - PROCESS | 27352 | __start_cc_report 18:16:01 INFO - PROCESS | 27352 | _x_x_mozilla_cycle_collect,1104 18:16:01 INFO - PROCESS | 27352 | __end_cc_report 18:16:01 INFO - PROCESS | 27352 | __startTimestamp1471396561846__endTimestamp 18:16:01 INFO - PROCESS | 27352 | 18:16:01 INFO - PROCESS | 27352 | ------- Summary: start ------- 18:16:01 INFO - PROCESS | 27352 | Number of tests: 6 18:16:01 INFO - PROCESS | 27352 | 18:16:01 INFO - PROCESS | 27352 | [#0] dojo.html Cycles:165 Average:4773.10 Median:4893.88 stddev:502.97 (10.3%) stddev-sans-first:475.77 18:16:01 INFO - PROCESS | 27352 | Values: 2636.4 2653.6 2672.8 2689.8 2691.5 4769.3 4810.5 4820.0 4859.1 4863.2 4717.9 4807.2 4874.7 4882.3 4901.0 4401.8 4467.8 4472.5 4505.9 4516.6 4467.7 4504.3 4504.7 4521.3 4568.2 4565.4 4587.3 4596.1 4605.1 4607.1 4374.2 4380.7 4419.0 4500.8 4554.6 4351.9 4357.1 4369.6 4377.9 4447.8 4833.0 4862.1 4878.3 4882.3 4892.7 4983.9 5039.4 5153.7 5204.7 5213.7 5099.9 5186.8 5188.3 5191.7 5196.7 4781.8 4822.4 4830.3 4831.0 4839.2 5155.4 5217.9 5278.2 5294.1 5299.0 5076.1 5135.8 5140.8 5143.7 5144.9 5179.4 5190.6 5192.4 5193.7 5227.1 4960.9 5071.7 5119.8 5129.7 5170.8 5131.8 5148.8 5155.3 5189.6 5206.8 4357.2 4361.8 4363.5 4390.8 4400.1 3754.2 3761.3 3762.7 3804.0 3838.0 4415.2 4419.9 4428.3 4482.9 4490.3 5215.3 5227.4 5228.6 5235.6 5280.2 4297.6 4336.5 4439.1 4451.8 4492.3 4567.2 4593.1 4608.7 4648.4 4663.8 4838.9 4851.8 4852.0 4856.1 4905.5 5054.1 5082.8 5126.4 5167.1 5212.5 4810.9 4869.4 4887.7 4905.0 4910.2 5076.9 5077.8 5094.5 5094.5 5127.6 4987.9 5142.9 5156.8 5157.7 5163.8 4977.9 5047.0 5048.5 5109.9 5115.7 5029.3 5035.8 5038.6 5039.1 5110.6 4960.2 4965.7 5010.3 5012.1 5046.9 4953.8 4964.2 5008.2 5014.0 5089.1 4868.9 4893.9 4909.5 4914.0 4930.4 18:16:01 INFO - PROCESS | 27352 | 18:16:01 INFO - PROCESS | 27352 | [#1] ext.html Cycles:180 Average:43913.67 Median:35800.23 stddev:79752.01 (222.8%) stddev-sans-first:79909.26 18:16:01 INFO - PROCESS | 27352 | Values: 544.0 566.3 569.1 571.2 572.9 28887.1 31516.5 31588.8 31611.5 31627.4 31553.0 39905.2 40880.4 41323.8 44601.3 7460.4 7557.9 7566.7 7574.3 7574.9 7609.5 7633.7 7682.3 7682.9 7693.0 7675.4 7707.4 7707.5 7712.1 7713.6 7663.7 7681.2 7715.1 7718.6 7719.4 7581.9 7604.0 7635.5 7640.9 7651.0 37968.6 38215.4 38227.8 38230.6 38273.4 2957.6 3143.9 3340.3 3361.9 3414.6 28242.2 28452.3 28522.6 28590.4 29790.9 3196.8 3243.2 3269.2 3340.5 3378.7 230447.0 230554.0 231060.0 232865.0 233154.0 27939.4 28621.7 52425.7 52785.7 52845.0 33118.8 33233.7 33532.8 33536.7 33573.7 12089.3 12298.5 12314.1 12326.7 12331.8 9532.8 9598.6 9618.7 9623.1 9633.7 7734.9 7833.9 7862.7 7898.2 7930.4 3127.5 3133.2 3134.7 3136.8 3180.7 811.3 827.9 873.8 938.5 999.7 25956.0 27860.2 27992.0 28008.2 28285.3 953.9 954.7 972.2 1008.6 1017.2 14176.4 14608.7 14830.7 14915.4 15273.5 370991.0 373038.0 373447.0 373718.0 375211.0 48853.3 49366.0 49426.8 49488.5 49498.0 1097.7 1126.3 1157.2 1168.4 1195.9 25843.0 28838.6 29641.4 29669.9 29882.4 41786.8 42237.8 42366.0 42378.4 42411.0 284451.0 285484.0 286007.0 286010.0 286047.0 22165.6 22915.5 24497.4 25574.6 25656.7 41399.8 41401.4 41677.4 42243.2 42453.4 35369.8 35738.8 35861.6 36087.0 36397.6 34635.7 35629.5 36080.6 36616.8 36819.6 35440.5 35546.0 36366.8 36370.3 36854.6 30948.0 33523.0 33600.0 33661.3 33699.5 25030.9 25411.0 25430.7 25607.2 25971.5 18:16:01 INFO - PROCESS | 27352 | 18:16:01 INFO - PROCESS | 27352 | [#2] jquery.html Cycles:180 Average:24393.53 Median:206712.41 stddev:62847.70 (30.4%) stddev-sans-first:62998.10 18:16:01 INFO - PROCESS | 27352 | Values: 358.2 369.4 373.1 382.3 383.0 16478.6 17173.2 17433.7 17491.2 17618.2 15345.7 15950.2 15981.5 16069.1 16103.2 4795.0 5046.9 5047.2 5049.5 5050.8 3705.4 4949.8 5679.7 5948.1 5962.3 5925.1 5985.3 5988.0 5988.1 5989.2 5716.1 5886.2 5896.5 5906.8 5912.3 5058.4 5118.7 5184.8 5191.1 5192.5 18907.3 19913.0 20800.9 21100.9 21123.9 1947.4 2031.6 2087.9 2413.1 2498.7 9373.8 9396.3 9504.9 9556.2 9801.6 1763.3 1776.6 1812.6 1812.8 1821.5 65692.0 66816.0 69029.7 69899.0 71128.0 9948.0 10025.3 10242.4 10298.8 10320.4 14013.4 14016.4 14018.9 14033.2 14055.5 6616.6 6732.1 6762.2 6953.2 6959.6 6289.8 6308.1 6318.7 6386.0 6569.7 4336.6 4391.5 4397.0 4420.4 4551.1 1708.3 1749.6 1757.3 1833.8 1889.4 790.6 823.1 888.7 891.8 918.6 16238.8 16397.8 16658.2 16890.7 17052.2 799.1 809.4 817.3 845.4 846.1 8327.7 9671.7 9837.5 9843.8 9906.5 372175.0 375505.0 383139.0 385097.0 385916.0 74224.6 79460.0 79675.0 80710.0 82419.0 781.7 803.7 850.5 866.7 871.9 14987.9 15402.8 16264.8 16300.4 16458.2 37427.6 37919.8 37960.4 38393.0 38879.2 49483.8 50121.0 50349.2 50480.0 51199.5 10397.8 10407.8 10547.7 10654.0 11059.7 12355.0 12432.3 12638.8 12769.7 12857.5 10159.8 10342.0 10947.3 11077.4 11232.5 11194.3 11228.7 11234.1 11384.4 11567.7 11227.2 11294.3 11557.8 11768.4 11783.9 10391.2 10537.5 10873.1 10910.2 11058.0 10996.5 11036.2 11158.5 11182.7 11597.7 18:16:01 INFO - PROCESS | 27352 | 18:16:01 INFO - PROCESS | 27352 | [#3] mootools.html Cycles:180 Average:5091.20 Median:4852.22 stddev:2874.77 (59.2%) stddev-sans-first:2869.02 18:16:01 INFO - PROCESS | 27352 | Values: 1341.5 1357.7 1434.6 1606.2 1638.8 7409.8 7958.2 7978.6 7998.9 8014.6 6670.8 6976.9 7435.5 7717.0 7785.8 2204.1 2231.7 2232.3 2233.8 2235.1 2173.2 2185.1 2215.0 2220.2 2221.2 2170.7 2171.2 2177.0 2178.1 2209.2 2150.3 2156.7 2157.6 2161.1 2162.4 2152.2 2177.7 2183.6 2183.8 2187.2 7923.4 7961.5 7970.8 7995.7 8006.4 4392.8 4454.3 4528.3 4536.8 4538.4 2961.2 3047.1 3116.1 3116.8 3124.3 926.2 983.1 988.7 990.3 996.4 10846.0 10847.7 10865.2 10867.7 10869.6 3954.8 4180.4 4254.7 4391.1 4395.9 9244.8 9246.4 9246.8 9254.0 9277.9 4503.1 4509.9 4526.9 4534.6 4535.7 3521.3 3953.1 4008.9 4025.0 4095.4 3615.1 3644.4 3753.1 3753.3 3756.1 1194.4 1203.5 1214.5 1218.4 1230.4 710.3 820.2 844.7 847.1 848.1 5020.8 5185.7 5268.2 5336.0 5389.3 398.2 411.5 413.1 416.3 419.2 3607.4 3619.2 3620.2 3675.9 3744.6 9015.0 9569.9 9605.2 9609.8 9611.9 9267.3 9425.2 9483.4 9497.0 9511.7 7257.9 7270.4 7343.5 7361.2 7368.4 4848.2 4856.3 4868.3 4931.7 5080.4 8514.3 8732.6 8839.4 8841.1 8910.0 8769.8 8868.4 8907.1 8981.8 8984.9 6575.8 6631.7 6678.0 6734.3 6809.0 7358.9 7440.1 7452.1 7459.3 7465.1 6483.1 6508.8 6513.3 6577.4 6831.7 6455.4 6499.4 6662.3 6694.5 6797.3 6046.0 6139.6 6142.4 6146.0 6150.8 4187.4 4452.7 4487.7 4582.4 4605.0 4490.3 4499.5 4524.3 4663.4 4788.2 18:16:01 INFO - PROCESS | 27352 | 18:16:01 INFO - PROCESS | 27352 | [#4] prototype.html Cycles:180 Average:4186.64 Median:4824.99 stddev:1200.40 (24.9%) stddev-sans-first:1167.80 18:16:01 INFO - PROCESS | 27352 | Values: 300.8 306.6 309.1 313.1 315.8 4823.1 4846.7 4856.2 4862.7 4886.4 4786.5 4791.6 4810.4 4826.9 4828.5 3623.2 3734.4 3746.3 3800.8 3803.2 3795.9 3797.8 3819.7 3831.3 3843.4 3757.8 3761.2 3770.4 3783.9 3806.9 3581.7 3649.9 3745.3 3767.5 3769.9 3342.5 3345.8 3346.7 3354.2 3354.4 4636.6 4650.7 4655.3 4657.6 4694.4 4162.8 4289.0 4289.1 4299.6 4307.6 4915.3 4951.6 4952.2 4986.4 5031.6 3627.6 3645.5 3651.6 3656.6 3668.7 5029.4 5231.2 5242.3 5251.7 5283.6 3652.3 3701.5 3702.3 3702.9 3721.3 3777.5 3778.3 3791.5 3800.6 3806.5 4298.5 4300.9 4316.2 4316.9 4321.5 4798.7 4995.9 5001.1 5009.5 5068.4 1305.1 1318.8 1318.8 1320.3 1324.5 829.7 860.2 860.2 875.2 875.6 4312.2 4425.2 4429.7 4437.7 4455.9 5117.0 5123.0 5158.0 5171.0 5176.8 4417.8 4423.1 4442.9 4468.3 4478.1 2616.6 2742.7 2752.6 2752.6 2755.9 4883.3 4895.3 4903.7 4916.2 4923.3 5055.8 5308.4 5313.7 5328.7 5330.8 4886.4 4916.5 4916.8 4946.8 4949.3 5183.7 5188.9 5222.6 5279.1 5279.8 4855.9 5092.3 5157.3 5169.8 5170.7 4872.2 4890.0 4906.2 4909.8 4936.4 3744.7 3777.1 3809.5 3810.6 3820.3 5024.3 5090.7 5140.0 5174.1 5176.3 4925.4 4933.0 4935.7 4943.3 4981.3 4921.7 4928.5 4959.2 5001.5 5026.4 4691.7 4879.7 4915.3 4923.5 4943.7 4851.6 4926.4 4947.0 4976.0 5027.5 4943.2 4947.2 4966.3 4966.5 5001.8 18:16:01 INFO - PROCESS | 27352 | 18:16:01 INFO - PROCESS | 27352 | [#5] yui.html Cycles:180 Average:17759.76 Median:593.63 stddev:26364.79 (4441.3%) stddev-sans-first:26407.34 18:16:01 INFO - PROCESS | 27352 | Values: 619.5 632.7 645.7 730.3 732.8 12087.8 12678.7 12722.2 12724.8 12725.8 13369.7 13435.3 13451.7 13510.7 13554.1 616.7 736.7 749.6 767.3 768.1 771.6 775.2 777.6 778.1 778.2 819.2 819.5 820.3 820.5 821.1 648.7 667.5 669.9 671.3 811.6 581.0 597.3 598.0 598.4 601.8 13240.9 13252.2 13272.5 13276.4 13310.1 12599.0 12870.7 13183.9 13382.0 13685.6 11536.4 11954.2 12096.9 12309.9 12557.0 4121.5 4178.9 4287.1 4342.1 4342.8 64895.7 65123.0 65165.7 65245.3 65936.3 10654.0 10834.9 10876.7 10927.8 10954.2 19455.2 19520.8 19531.9 19545.4 19622.4 6608.1 6678.6 6776.6 6888.4 6974.6 3577.3 3650.2 3684.3 3704.5 3764.9 2763.7 2831.4 2865.5 2889.7 2893.6 479.8 493.4 496.3 512.1 519.7 486.6 519.5 534.5 555.4 559.0 6838.3 6938.4 7178.5 7255.9 8254.7 563.8 584.7 590.8 596.5 600.2 3610.9 3813.2 3833.4 3876.4 3930.6 105746.0 107882.0 108438.0 110096.0 110416.4 49651.3 71915.0 85411.0 86185.6 86619.0 48513.3 61385.0 80348.0 80899.6 81848.0 7268.4 7550.7 7575.6 7738.2 7754.9 44819.0 45215.0 45688.3 46981.3 46985.0 65172.7 69101.3 69199.3 70384.0 70802.3 9451.1 9477.7 9485.5 9787.9 9934.7 10535.4 10695.9 10704.9 11499.1 11512.5 9122.7 9127.2 9446.7 9450.1 9470.6 9855.2 9989.8 10087.9 10263.3 10290.1 9559.3 9715.5 9767.6 10086.7 10187.5 8408.5 8455.6 8679.1 8877.2 8889.9 8094.2 8470.0 8534.5 8548.9 8753.2 18:16:01 INFO - PROCESS | 27352 | -------- Summary: end -------- 18:16:01 INFO - PROCESS | 27352 | 18:16:02 INFO - TEST-INFO | 27352: exit 0 18:16:02 INFO - TEST-OK | dromaeo_css | took 1120600ms 18:16:02 INFO - TEST-START | kraken 18:16:02 INFO - operating with platform_type : linux_ 18:16:02 INFO - Initialising browser for kraken test... 18:16:02 INFO - TEST-INFO | started process 27651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKxOTed/profile http://localhost:43742/getInfo.html) 18:16:07 INFO - PROCESS | 27651 | __metrics Screen width/height:1600/1200 18:16:07 INFO - PROCESS | 27651 | colorDepth:24 18:16:07 INFO - PROCESS | 27651 | Browser inner width/height: 1024/697 18:16:07 INFO - PROCESS | 27651 | __metrics 18:16:07 INFO - PROCESS | 27651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:16:07 INFO - PROCESS | 27651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:16:08 INFO - PROCESS | 27651 | console.error: PushService: 18:16:08 INFO - PROCESS | 27651 | stateChangeProcessEnqueue: Error transitioning state 18:16:08 INFO - PROCESS | 27651 | UnknownError 18:16:08 INFO - TEST-INFO | 27651: exit 0 18:16:08 INFO - Browser initialized. 18:16:08 INFO - Running cycle 1/1 for kraken test... 18:16:08 INFO - TEST-INFO | started process 27729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKxOTed/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:16:20 INFO - PROCESS | 27729 | RSS: Main: 156274688 18:16:20 INFO - PROCESS | 27729 | 18:16:23 INFO - PROCESS | 27729 | Cycle 1(1): loaded http://localhost:43742/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43742/tests/kraken/driver.html?testName=audio-beat-detection) 18:16:24 INFO - PROCESS | 27729 | RSS: Main: 204263424 18:16:24 INFO - PROCESS | 27729 | 18:16:27 INFO - PROCESS | 27729 | Cycle 1(1): loaded http://localhost:43742/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43742/tests/kraken/driver.html?testName=audio-dft) 18:16:27 INFO - PROCESS | 27729 | RSS: Main: 194506752 18:16:27 INFO - PROCESS | 27729 | 18:16:31 INFO - PROCESS | 27729 | Cycle 1(1): loaded http://localhost:43742/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43742/tests/kraken/driver.html?testName=audio-fft) 18:16:31 INFO - PROCESS | 27729 | RSS: Main: 276107264 18:16:31 INFO - PROCESS | 27729 | 18:16:33 INFO - PROCESS | 27729 | Cycle 1(1): loaded http://localhost:43742/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43742/tests/kraken/driver.html?testName=audio-oscillator) 18:16:34 INFO - PROCESS | 27729 | RSS: Main: 185282560 18:16:34 INFO - PROCESS | 27729 | 18:16:36 INFO - PROCESS | 27729 | Cycle 1(1): loaded http://localhost:43742/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43742/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:16:37 INFO - PROCESS | 27729 | RSS: Main: 190496768 18:16:37 INFO - PROCESS | 27729 | 18:16:40 INFO - PROCESS | 27729 | Cycle 1(1): loaded http://localhost:43742/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43742/tests/kraken/driver.html?testName=imaging-darkroom) 18:16:41 INFO - PROCESS | 27729 | RSS: Main: 226992128 18:16:41 INFO - PROCESS | 27729 | 18:16:44 INFO - PROCESS | 27729 | Cycle 1(1): loaded http://localhost:43742/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43742/tests/kraken/driver.html?testName=imaging-desaturate) 18:16:45 INFO - PROCESS | 27729 | RSS: Main: 220913664 18:16:45 INFO - PROCESS | 27729 | 18:16:48 INFO - PROCESS | 27729 | Cycle 1(1): loaded http://localhost:43742/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43742/tests/kraken/driver.html?testName=json-parse-financial) 18:16:48 INFO - PROCESS | 27729 | RSS: Main: 224444416 18:16:48 INFO - PROCESS | 27729 | 18:16:50 INFO - PROCESS | 27729 | Cycle 1(1): loaded http://localhost:43742/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43742/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:16:51 INFO - PROCESS | 27729 | RSS: Main: 187588608 18:16:51 INFO - PROCESS | 27729 | 18:16:53 INFO - PROCESS | 27729 | Cycle 1(1): loaded http://localhost:43742/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43742/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:16:53 INFO - PROCESS | 27729 | RSS: Main: 195534848 18:16:53 INFO - PROCESS | 27729 | 18:16:55 INFO - PROCESS | 27729 | Cycle 1(1): loaded http://localhost:43742/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43742/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:16:56 INFO - PROCESS | 27729 | RSS: Main: 192454656 18:16:56 INFO - PROCESS | 27729 | 18:16:59 INFO - PROCESS | 27729 | Cycle 1(1): loaded http://localhost:43742/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:16:59 INFO - PROCESS | 27729 | RSS: Main: 187416576 18:16:59 INFO - PROCESS | 27729 | 18:17:02 INFO - PROCESS | 27729 | Cycle 1(1): loaded http://localhost:43742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:17:03 INFO - PROCESS | 27729 | RSS: Main: 191180800 18:17:03 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | Cycle 1(1): loaded http://localhost:43742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43742/tests/kraken/driver.html?testName=ai-astar) 18:17:05 INFO - PROCESS | 27729 | RSS: Main: 242036736 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | __start_tp_report 18:17:05 INFO - PROCESS | 27729 | _x_x_mozilla_page_load 18:17:05 INFO - PROCESS | 27729 | _x_x_mozilla_page_load_details 18:17:05 INFO - PROCESS | 27729 | |i|pagename|runs| 18:17:05 INFO - PROCESS | 27729 | |0;ai-astar;108;114;114;118;109;114;114;115;115;113 18:17:05 INFO - PROCESS | 27729 | |1;audio-beat-detection;144;121;128;175;123;129;146;122;163;121 18:17:05 INFO - PROCESS | 27729 | |2;audio-dft;162;161;160;160;161;161;161;163;161;162 18:17:05 INFO - PROCESS | 27729 | |3;audio-fft;76;78;74;101;77;78;75;75;105;75 18:17:05 INFO - PROCESS | 27729 | |4;audio-oscillator;88;86;122;86;86;86;129;86;87;133 18:17:05 INFO - PROCESS | 27729 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;117;116 18:17:05 INFO - PROCESS | 27729 | |6;imaging-darkroom;147;145;147;146;146;145;147;146;146;146 18:17:05 INFO - PROCESS | 27729 | |7;imaging-desaturate;95;95;95;95;95;96;94;94;95;94 18:17:05 INFO - PROCESS | 27729 | |8;json-parse-financial;65;63;67;65;65;67;65;65;66;65 18:17:05 INFO - PROCESS | 27729 | |9;json-stringify-tinderbox;66;67;67;67;66;67;68;66;67;66 18:17:05 INFO - PROCESS | 27729 | |10;stanford-crypto-aes;84;91;81;81;82;81;90;82;84;81 18:17:05 INFO - PROCESS | 27729 | |11;stanford-crypto-ccm;135;131;132;135;138;131;132;131;157;141 18:17:05 INFO - PROCESS | 27729 | |12;stanford-crypto-pbkdf2;171;180;168;170;177;171;173;171;168;175 18:17:05 INFO - PROCESS | 27729 | |13;stanford-crypto-sha256-iterative;67;68;70;68;68;68;68;67;69;69 18:17:05 INFO - PROCESS | 27729 | __end_tp_report 18:17:05 INFO - PROCESS | 27729 | __start_cc_report 18:17:05 INFO - PROCESS | 27729 | _x_x_mozilla_cycle_collect,1917 18:17:05 INFO - PROCESS | 27729 | __end_cc_report 18:17:05 INFO - PROCESS | 27729 | __startTimestamp1471396625414__endTimestamp 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | ------- Summary: start ------- 18:17:05 INFO - PROCESS | 27729 | Number of tests: 14 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:2.91 (2.6%) stddev-sans-first:2.35 18:17:05 INFO - PROCESS | 27729 | Values: 108.0 114.0 114.0 118.0 109.0 114.0 114.0 115.0 115.0 113.0 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:136.50 stddev:19.23 (14.1%) stddev-sans-first:20.24 18:17:05 INFO - PROCESS | 27729 | Values: 144.0 121.0 128.0 175.0 123.0 129.0 146.0 122.0 163.0 121.0 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 18:17:05 INFO - PROCESS | 27729 | Values: 162.0 161.0 160.0 160.0 161.0 161.0 161.0 163.0 161.0 162.0 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.50 stddev:11.50 (15.2%) stddev-sans-first:12.03 18:17:05 INFO - PROCESS | 27729 | Values: 76.0 78.0 74.0 101.0 77.0 78.0 75.0 75.0 105.0 75.0 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | [#4] audio-oscillator Cycles:10 Average:98.90 Median:86.00 stddev:20.26 (23.6%) stddev-sans-first:21.10 18:17:05 INFO - PROCESS | 27729 | Values: 88.0 86.0 122.0 86.0 86.0 86.0 129.0 86.0 87.0 133.0 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:17:05 INFO - PROCESS | 27729 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 18:17:05 INFO - PROCESS | 27729 | Values: 147.0 145.0 147.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 18:17:05 INFO - PROCESS | 27729 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 94.0 94.0 95.0 94.0 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 18:17:05 INFO - PROCESS | 27729 | Values: 65.0 63.0 67.0 65.0 65.0 67.0 65.0 65.0 66.0 65.0 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 18:17:05 INFO - PROCESS | 27729 | Values: 66.0 67.0 67.0 67.0 66.0 67.0 68.0 66.0 67.0 66.0 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:3.77 (4.5%) stddev-sans-first:4.00 18:17:05 INFO - PROCESS | 27729 | Values: 84.0 91.0 81.0 81.0 82.0 81.0 90.0 82.0 84.0 81.0 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:135.00 stddev:8.01 (5.9%) stddev-sans-first:8.49 18:17:05 INFO - PROCESS | 27729 | Values: 135.0 131.0 132.0 135.0 138.0 131.0 132.0 131.0 157.0 141.0 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:172.00 stddev:3.89 (2.3%) stddev-sans-first:4.10 18:17:05 INFO - PROCESS | 27729 | Values: 171.0 180.0 168.0 170.0 177.0 171.0 173.0 171.0 168.0 175.0 18:17:05 INFO - PROCESS | 27729 | 18:17:05 INFO - PROCESS | 27729 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 18:17:05 INFO - PROCESS | 27729 | Values: 67.0 68.0 70.0 68.0 68.0 68.0 68.0 67.0 69.0 69.0 18:17:05 INFO - PROCESS | 27729 | -------- Summary: end -------- 18:17:05 INFO - PROCESS | 27729 | 18:17:06 INFO - TEST-INFO | 27729: exit 0 18:17:06 INFO - TEST-OK | kraken | took 63756ms 18:17:06 INFO - SUITE-END | took 1184s 18:17:06 INFO - Completed test suite (00:19:44) 18:17:06 INFO - javascript benchmark 18:17:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2636.406808468095, 2653.6417583626203, 2672.799540034497, 2689.811713180077, 2691.5020721166584, 4769.260764581487, 4810.494898035704, 4819.951800481994, 4859.149648811462, 4863.221884498476, 4717.882052948678, 4807.206810876201, 4874.6831455955335, 4882.340883980662, 4900.950990490094, 4401.779911004453, 4467.7542735149555, 4472.508024117345, 4505.93241101383, 4516.570925762064, 4467.664925130612, 4504.279315309551, 4504.707194032378, 4521.299198624219, 4568.200564901145, 4565.429321334816, 4587.334836448713, 4596.057808149338, 4605.148047611203, 4607.07858428314, 4374.212641724488, 4380.693351465398, 4419.049904270565, 4500.774961251957, 4554.612857907082, 4351.912961740747, 4357.106793107406, 4369.58488943553, 4377.868663940055, 4447.799849006802, 4832.9758351208375, 4862.07620552094, 4878.317035615017, 4882.292067650206, 4892.730899800509, 4983.8504844854715, 5039.445660977326, 5153.742312884378, 5204.739763011872, 5213.661112027706, 5099.87250318745, 5186.7925282988635, 5188.273641690166, 5191.662541934762, 5196.662216955886, 4781.784819683123, 4822.373091498082, 4830.275458681155, 4831.0096430231715, 4839.177339852234, 5155.432902380735, 5217.921731174036, 5278.155495120763, 5294.073537130987, 5298.97350513245, 5076.060928728123, 5135.845924622267, 5140.794368225229, 5143.71709555978, 5144.948550514447, 5179.404368497671, 5190.636655434083, 5192.3769147702515, 5193.662411943287, 5227.085260079471, 4960.90078198434, 5071.695698258116, 5119.769610367543, 5129.743512824419, 5170.844874653766, 5131.820386286462, 5148.768305426265, 5155.329807125125, 5189.558887494605, 5206.817761378334, 4357.237483440385, 4361.781910904506, 4363.52001279859, 4390.780460976938, 4400.075984043323, 3754.1740817020213, 3761.2853557824474, 3762.680172185395, 3803.980980095137, 3837.9808100959317, 4415.249407600716, 4419.867403977886, 4428.291473364311, 4482.8655140345845, 4490.3040028795585, 5215.295935048795, 5227.372715274116, 5228.55557277628, 5235.633505654568, 5280.207968804633, 4297.613214810682, 4336.501302350207, 4439.089986552749, 4451.821927122944, 4492.281235002384, 4567.1550763108935, 4593.127305811885, 4608.677392582554, 4648.395708557933, 4663.766811659403, 4838.879028024327, 4851.781669824937, 4851.95148048515, 4856.077345304381, 4905.484924083063, 5054.115529782347, 5082.8475145744205, 5126.359205099363, 5167.1474206755465, 5212.50481204285, 4810.855674329776, 4869.415670119608, 4887.731174785279, 4904.950950490449, 4910.21436570147, 5076.949230507796, 5077.7968881245815, 5094.465081166424, 5094.541491265803, 5127.5897928166405, 4987.9251811223585, 5142.922856157086, 5156.793728250828, 5157.6647517911215, 5163.793448262178, 4977.925331120108, 5047.0, 5048.5203905628905, 5109.8978020438635, 5115.744212789271, 5029.295898574275, 5035.798568057383, 5038.622103342191, 5039.067772462106, 5110.565601923878, 4960.181570040902, 4965.652404331662, 5010.323606313247, 5012.072766538202, 5046.924296135488, 4953.826616068564, 4964.230544265644, 5008.248762685626, 5014.0, 5089.083964886356, 4868.853934381974, 4893.877653058702, 4909.5090490950615, 4914.041761856403, 4930.383702037246], "value": 4740.461821377376, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.0397698062918, 566.3373852592466, 569.1235497334104, 571.1775043936733, 572.8796952639946, 28887.133385998426, 31516.527252091237, 31588.842055789748, 31611.525827112582, 31627.367452650935, 31553.0, 39905.20189596206, 40880.38679419811, 41323.79338103313, 44601.33098003524, 7460.36586890115, 7557.886631700529, 7566.697332106709, 7574.280443357872, 7574.886376704354, 7609.505382150171, 7633.694652213905, 7682.347000504964, 7682.923170768277, 7693.038370203724, 7675.424343174284, 7707.383409327241, 7707.537547747125, 7712.113106992683, 7713.614319284014, 7663.655135518887, 7681.155072941972, 7715.074191097048, 7718.575478348688, 7719.421043421766, 7581.886271705929, 7604.0, 7635.541867487968, 7640.885386719204, 7651.043619547557, 37968.62031379678, 38215.426768598496, 38227.80886095552, 38230.617693822984, 38273.425898611546, 2957.600723902267, 3143.921401964946, 3340.28183940454, 3361.8991430257133, 3414.5902491701154, 28242.15273541797, 28452.28869278264, 28522.572161417596, 28590.428191436054, 29790.85104574485, 3196.7762256642045, 3243.189202699325, 3269.1500209945348, 3340.4822252550653, 3378.6959173674486, 230447.0, 230554.0, 231060.0, 232865.0, 233154.0, 27939.44121117607, 28621.71378286232, 52425.73787131116, 52785.7360713194, 52845.0, 33118.834405827816, 33233.66766332306, 33532.83233583817, 33536.664633353845, 33573.66426335705, 12089.274643521418, 12298.508059677692, 12314.076444266715, 12326.691832704255, 12331.815022774666, 9532.761680958032, 9598.568064437117, 9618.663346782829, 9623.133917947418, 9633.710988670211, 7734.883976740353, 7833.921660783433, 7862.72480463181, 7898.210178982055, 7930.44486885924, 3127.5465057566526, 3133.1697100268448, 3134.7492200623897, 3136.81179129253, 3180.6501284858646, 811.2820154163608, 827.8592639251342, 873.8296032273646, 938.5354249646468, 999.6551189839639, 25956.0, 27860.16419507418, 27992.0, 28008.159755207376, 28285.29286767806, 953.8998405167496, 954.6944977607099, 972.2125078686287, 1008.621766837436, 1017.1710056304237, 14176.362063707158, 14608.707825843423, 14830.70338593222, 14915.403383864741, 15273.541793746206, 370991.0, 373038.0, 373447.0, 373718.0, 375211.0, 48853.26720099201, 49366.0, 49426.75286623544, 49488.50511494839, 49498.0, 1097.6981330134117, 1126.3354620773782, 1157.2304417562395, 1168.4391492083678, 1195.8804119588146, 25843.0, 28838.567421488275, 29641.407171856874, 29669.85165074161, 29882.402351952405, 41786.79106604569, 42237.78881105575, 42366.0, 42378.364324535774, 42411.0, 284451.0, 285484.0, 286007.0, 286010.0, 286047.0, 22165.55668886581, 22915.541689166457, 24497.387565311008, 25574.61638075393, 25656.743432565436, 41399.7930010348, 41401.37897931594, 41677.374839376826, 42243.1551368977, 42453.363199551415, 35369.82315088408, 35738.8213058933, 35861.64138358583, 36087.0, 36397.63602364049, 34635.65364346324, 35629.465558016134, 36080.63919360773, 36616.81691591525, 36819.63180368162, 35440.46839297361, 35546.0, 36366.818165909004, 36370.27259454849, 36854.63145368512, 30948.0, 33523.0, 33600.0, 33661.32677346488, 33699.49450758191, 25030.874845625654, 25410.967122629776, 25430.745692543576, 25607.23178304654, 25971.48057038811], "value": 15981.995283849674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.1708345180906, 369.43476480984094, 373.1343283582089, 382.269864558693, 382.9712771542135, 16478.588035299108, 17173.227204775783, 17433.738493922585, 17491.212895419703, 17618.20718067687, 15345.69308613827, 15950.202489875488, 15981.520554383358, 16069.116198609072, 16103.194840257998, 4794.9520504794855, 5046.899062018758, 5047.167217409123, 5049.48515445365, 5050.7979680812905, 3705.407134858423, 4949.7772600233075, 5679.7160141992945, 5948.107783832438, 5962.25471816023, 5925.051991681332, 5985.281766188064, 5987.970060149693, 5988.101784732282, 5989.191459153002, 5716.085426331788, 5886.234789477383, 5896.528277737771, 5906.763729450817, 5912.3496415394275, 5058.392992840846, 5118.658448331772, 5184.807494276338, 5191.091558977164, 5192.454792246797, 18907.338243161423, 19913.0, 20800.895995519924, 21100.894495527577, 21123.894380528, 1947.4255094747084, 2031.6343058249508, 2087.9164833406644, 2413.095089341497, 2498.675172227599, 9373.765655858659, 9396.295277854188, 9504.857427138599, 9556.23550115989, 9801.558929848174, 1763.2682436788718, 1776.564741638294, 1812.5831058856536, 1812.7824661040759, 1821.4990877508658, 65692.0, 66816.0, 69029.65485172592, 69899.0, 71128.0, 9948.0, 10025.298229124037, 10242.436665983443, 10298.845517317246, 10320.43237621938, 14013.439462421593, 14016.369263383172, 14018.929905350407, 14033.1580105194, 14055.508057217949, 6616.636085015274, 6732.124823772878, 6762.154730658668, 6953.165620125617, 6959.598938366255, 6289.811305660837, 6308.053791931247, 6318.684065796784, 6386.0, 6569.67151642416, 4336.566343365638, 4391.494978077562, 4397.01067259864, 4420.381146639473, 4551.13528429604, 1708.2910592104386, 1749.5713550180287, 1757.2970811675432, 1833.758459006464, 1889.4331700489797, 790.6481615681082, 823.1357075071152, 888.6800751729372, 891.8439273127307, 918.5774543709834, 16238.837611623969, 16397.83602163987, 16658.16709164537, 16890.662186756195, 17052.2326495308, 799.0571126071292, 809.4333966223667, 817.3420396580691, 845.3913182508584, 846.1158089796178, 8327.708530201535, 9671.661491847752, 9837.508124593742, 9843.753906152404, 9906.504674766233, 372175.0, 375505.0, 383139.0, 385097.0, 385916.0, 74224.59786590225, 79460.0, 79674.99999999884, 80710.0, 82419.0, 781.7107670162077, 803.6704950970075, 850.46420754924, 866.6923242248911, 871.930245580352, 14987.850121498646, 15402.768958465856, 16264.756028659816, 16300.42948496797, 16458.177091145633, 37427.625723742414, 37919.81040094782, 37960.43059354167, 38393.0, 38879.222415552096, 49483.75258123686, 50120.99758004893, 50349.24476132934, 50480.0, 51199.48800512096, 10397.84403233937, 10407.843882341922, 10547.736306592396, 10654.0, 11059.668209953714, 12355.0, 12432.316222607844, 12638.810417843555, 12769.680757981125, 12857.549985750455, 10159.796804064024, 10342.0, 10947.307400152036, 11077.390743509184, 11232.494537745657, 11194.272372295774, 11228.66314010581, 11234.101271898066, 11384.430778460877, 11567.710807229887, 11227.21409501327, 11294.322340659586, 11557.82663260035, 11768.352740599006, 11783.880531349509, 10391.181543229754, 10537.52581133866, 10873.07578855806, 10910.23628346008, 11058.0, 10996.505157268102, 11036.227464077438, 11158.497867595815, 11182.72043198894, 11597.710057248636], "value": 8460.851082248277, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.5371696764612, 1357.7148798752262, 1434.5767998440458, 1606.1808477676382, 1638.8443097905695, 7409.777706668802, 7958.204179582039, 7978.640961156754, 7998.92001079989, 8014.5992700364895, 6670.76652317169, 6976.860462790741, 7435.516691415054, 7717.0, 7785.844283114348, 2204.1073365287043, 2231.6987206727126, 2232.2521955145044, 2233.7542870284256, 2235.1282999630157, 2173.152470536484, 2185.115028413487, 2214.9778502215013, 2220.222921977311, 2221.178164079293, 2170.717806685129, 2171.2183613898983, 2176.967345489819, 2178.0743184146672, 2209.171560664751, 2150.2796563151364, 2156.6657168138886, 2157.600843843894, 2161.1247444784885, 2162.4053385319007, 2152.2359562355296, 2177.69512268281, 2183.552371763785, 2183.759786423492, 2187.201671389947, 7923.445358824884, 7961.522308661499, 7970.800729981739, 7995.6801727930815, 8006.399520035962, 4392.780360981938, 4454.331850222493, 4528.343390208434, 4536.818527258905, 4538.387317712132, 2961.185673939662, 3047.0554128220324, 3116.1274843043984, 3116.7974081684843, 3124.297033167542, 926.249737712455, 983.1348413396237, 988.6786794291812, 990.3216296836617, 996.4021587047786, 10846.0, 10847.67456976292, 10865.239433239676, 10867.673969780999, 10869.619563315246, 3954.762714237155, 4180.414741936132, 4254.680898932531, 4391.1217756448195, 4395.890102747393, 9244.768880778034, 9246.445213287225, 9246.768830779285, 9254.028327025566, 9277.907220927704, 4503.054358584668, 4509.88725281864, 4526.936170000047, 4534.614557762561, 4535.659825513099, 3521.3485505181625, 3953.1303113315025, 4008.8596899108975, 4024.9798751006642, 4095.406166105898, 3615.1323682316056, 3644.3986742187244, 3753.0992561784974, 3753.305638456894, 3756.0609847538117, 1194.4027986006997, 1203.500547272872, 1214.4656351205442, 1218.3542722357165, 1230.4278510492663, 710.3039021758706, 820.156973073999, 844.6705784743955, 847.1486156412766, 848.1476116502876, 5020.7740651670765, 5185.688858668492, 5268.209768534751, 5335.973320133375, 5389.299391079135, 398.1797497155868, 411.4959175010588, 413.1138707472515, 416.26736942980574, 419.1805021183579, 3607.3867442534834, 3619.2399596085115, 3620.2035552178477, 3675.889723308305, 3744.6068162842507, 9014.954925225333, 9569.89946156187, 9605.231581473465, 9609.807803843883, 9611.855822162674, 9267.25861931044, 9425.151736343762, 9483.383580067273, 9497.0, 9511.66709165176, 7257.8548429031125, 7270.418366530665, 7343.522671026473, 7361.153467351323, 7368.447366447431, 4848.151573474698, 4856.295837103671, 4868.342773725643, 4931.704097754003, 5080.364954380702, 8514.318854491501, 8732.60703268367, 8839.381243312906, 8841.071687472722, 8909.955450222707, 8769.824603507766, 8868.423552469068, 8907.064758200295, 8981.82036359256, 8984.91015089867, 6575.80272591823, 6631.734730610721, 6678.0, 6734.326567343226, 6809.012693159563, 7358.889616655862, 7440.144383395978, 7452.143003554444, 7459.291367320096, 7465.06686664167, 6483.092367068709, 6508.837279067871, 6513.2835388108215, 6577.440917522064, 6831.726730930707, 6455.354464553507, 6499.38255865692, 6662.267150613526, 6694.531382803157, 6797.25230224665, 6045.969770151121, 6139.6009259398, 6142.385761423822, 6145.9692701536205, 6150.846228844314, 4187.392828039978, 4452.732836029849, 4487.7307361557105, 4582.358469814162, 4604.953950460453, 4490.326451032241, 4499.5275496072445, 4524.298733696282, 4663.417072865892, 4788.209945358977], "value": 4041.6408401514004, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.8375477242289, 306.56161688785045, 309.07740394921154, 313.07642454758457, 315.7710659771664, 4823.13183626947, 4846.74626298771, 4856.198727210015, 4862.708237505753, 4886.438059623144, 4786.473487916326, 4791.592714619262, 4810.436608102364, 4826.855194344175, 4828.5412885775795, 3623.202895363016, 3734.3838266685966, 3746.3256613809504, 3800.8289626966716, 3803.1823158021157, 3795.8861234162882, 3797.829097690597, 3819.694424446038, 3831.329517334469, 3843.4427008083812, 3757.755745876509, 3761.153740408414, 3770.359038963383, 3783.924321513568, 3806.9428958565645, 3581.6776490115885, 3649.8540058397634, 3745.325841348556, 3767.472553842464, 3769.9067270491523, 3342.4819153031317, 3345.7955136150968, 3346.657339862082, 3354.194993201638, 3354.3626710924846, 4636.559526844944, 4650.7442090685, 4655.324083329999, 4657.557532034485, 4694.36626055485, 4162.771047592381, 4288.957110428918, 4289.142171565668, 4299.634531064863, 4307.590778876001, 4915.262710593403, 4951.62862785289, 4952.232403977389, 4986.376702912136, 5031.647784655075, 3627.619099994489, 3645.4714066460215, 3651.6165802590613, 3656.568382025976, 3668.7248456365614, 5029.446760856339, 5231.163013917793, 5242.344706911636, 5251.68489890604, 5283.55089817366, 3652.2695460907926, 3701.5373078365205, 3702.296563652951, 3702.9446607716673, 3721.3115573618966, 3777.527809023872, 3778.301014312361, 3791.4881490998364, 3800.638939300762, 3806.4861243731743, 4298.527162012176, 4300.89247768802, 4316.1583491219535, 4316.892077698019, 4321.459817522809, 4798.712077275305, 4995.850124496271, 5001.124803159432, 5009.547231302954, 5068.350787433043, 1305.0799186573443, 1318.775808112623, 1318.81965640751, 1320.2540564581172, 1324.4900713225477, 829.6930135849653, 860.1957170045902, 860.2086080805674, 875.2123089219754, 875.60160127142, 4312.180685669713, 4425.247707889666, 4429.667774916894, 4437.689361744647, 4455.888602784891, 5116.951025039933, 5122.974385128051, 5157.974210128926, 5171.0, 5176.818811341585, 4417.763026352626, 4423.137488189772, 4442.911141777146, 4468.302045222795, 4478.081993191388, 2616.5944278636844, 2742.684591272029, 2752.6008728734223, 2752.6146339512484, 2755.9035433759723, 4883.291922671193, 4895.265710143507, 4903.681260718114, 4916.164252077084, 4923.276853101457, 5055.823046193365, 5308.362996440452, 5313.681179129265, 5328.706921119298, 5330.840074797762, 4886.438059623118, 4916.508349165055, 4916.754162291871, 4946.802127914915, 4949.28235405857, 5183.714895680774, 5188.922166167435, 5222.6083043771105, 5279.093470831634, 5279.759256574625, 4855.854324370274, 5092.337996060489, 5157.303763991813, 5169.7673604687125, 5170.689758614495, 4872.220444728827, 4890.0, 4906.215005599087, 4909.828156014522, 4936.420345489409, 3744.7378683491893, 3777.0934975606206, 3809.542854857435, 3810.5808361079703, 3820.255050265283, 5024.296598476143, 5090.745462726923, 5140.0, 5174.120399532013, 5176.334187893162, 4925.408950925912, 4932.975335123301, 4935.654504184817, 4943.2585112233455, 4981.285199566318, 4921.704697718148, 4928.507149285043, 4959.156943319572, 5001.4998500149695, 5026.396832380138, 4691.7184968901975, 4879.73161476108, 4915.279652121729, 4923.483034281349, 4943.714634195063, 4851.58761505276, 4926.433460152129, 4946.950530494649, 4975.950240497548, 5027.547520723152, 4943.184374578154, 4947.233178857283, 4966.279889415942, 4966.478519755374, 5001.824936127218], "value": 3808.405053298317, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.4579742725118, 632.7310892870529, 645.6578013652766, 730.3025610541933, 732.8204589875478, 12087.75824483511, 12678.746425071517, 12722.23666580006, 12724.809127863078, 12725.809112863302, 13369.732605347886, 13435.32823358833, 13451.66370840727, 13510.729785404286, 13554.051216414855, 616.7101462312706, 736.661135877497, 749.6064566102785, 767.2710924621604, 768.0629631849163, 771.6103367799253, 775.2363921537282, 777.6228529163351, 778.0857492446381, 778.2101167315179, 819.1521774962914, 819.5082950229844, 820.3109388113983, 820.4748960665149, 821.0557858462756, 648.691871361102, 667.5293917787997, 669.9028640847099, 671.318611609217, 811.6063709101081, 580.9796657117023, 597.3399393670019, 598.0162632469563, 598.4344794169511, 601.8465291350722, 13240.86759132406, 13252.20486770797, 13272.535461258905, 13276.402561884739, 13310.068295219338, 12599.0, 12870.742585148244, 13183.86816131836, 13382.0, 13685.589432317047, 11536.365499897502, 11954.222975506564, 12096.939515302367, 12309.93845030769, 12556.967080140728, 4121.505419349667, 4178.895527611804, 4287.078278170208, 4342.131573685276, 4342.848000320006, 64895.70208595849, 65123.0, 65165.67417162884, 65245.347546524405, 65936.3406365935, 10654.0, 10834.891651083388, 10876.728081798019, 10927.836082458769, 10954.178436617285, 19455.22179112848, 19520.80479195218, 19531.902340488206, 19545.413637590897, 19622.411327660193, 6608.107905432801, 6678.632675202911, 6776.559523630948, 6888.41448476885, 6974.616396098162, 3577.338192434408, 3650.233450975325, 3684.299983003221, 3704.518412606344, 3764.8682296119505, 2763.7374449427675, 2831.419558990402, 2865.5415133578526, 2889.6821349651523, 2893.594896714462, 479.7769037397627, 493.40298239131056, 496.33491121896833, 512.078259133558, 519.714157213531, 486.5985561911437, 519.498683770156, 534.5242733966695, 555.4390066033335, 559.0384538593612, 6838.281980392087, 6938.444924406035, 7178.461615378763, 7255.8911616325795, 8254.669813207405, 563.7857614106696, 584.6755050946765, 590.7991282963812, 596.4631831351818, 600.1747597054051, 3610.909727256787, 3813.2373525294497, 3833.386658134685, 3876.3991581304945, 3930.6069393060466, 105746.0, 107882.0, 108438.0, 110096.0, 110416.4479177599, 49651.25523117156, 71915.0, 85411.0, 86185.56907215423, 86619.0, 48513.272300915516, 61385.0, 80348.0, 80899.59550202212, 81848.0, 7268.41852651776, 7550.735724249625, 7575.583342915972, 7738.2261773822165, 7754.92245077542, 44819.0, 45215.0, 45688.31467527923, 46981.295280570135, 46985.0, 65172.674136629015, 69101.30898690948, 69199.30800691928, 70384.0, 70802.29197707957, 9451.102145296185, 9477.715668529956, 9485.525723713925, 9787.902120978699, 9934.701958941243, 10535.42055186972, 10695.94652026735, 10704.946475267574, 11499.080073593925, 11512.481938312629, 9122.680706175252, 9127.161709279251, 9446.669366572138, 9450.102240287162, 9470.621175152917, 9855.162311203341, 9989.750256243651, 10087.89033206332, 10263.332883362558, 10290.12533934624, 9559.330846840932, 9715.465649389069, 9767.609295628095, 10086.697399078039, 10187.541560629641, 8408.495490270603, 8455.577221138796, 8679.132086791271, 8877.201051905102, 8889.911100888909, 8094.190580941859, 8470.017614682522, 8534.530600817016, 8548.871766923625, 8753.168448997336], "value": 6361.986654184173, "unit": "score"}], "name": "dromaeo_css", "value": 6304.262745712298, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 114.0, 118.0, 109.0, 114.0, 114.0, 115.0, 115.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 121.0, 128.0, 175.0, 123.0, 129.0, 146.0, 122.0, 163.0, 121.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 160.0, 161.0, 161.0, 161.0, 163.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 74.0, 101.0, 77.0, 78.0, 75.0, 75.0, 105.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 122.0, 86.0, 86.0, 86.0, 129.0, 86.0, 87.0, 133.0], "value": 98.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 94.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 67.0, 65.0, 65.0, 67.0, 65.0, 65.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 68.0, 66.0, 67.0, 66.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 91.0, 81.0, 81.0, 82.0, 81.0, 90.0, 82.0, 84.0, 81.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 132.0, 135.0, 138.0, 131.0, 132.0, 131.0, 157.0, 141.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 180.0, 168.0, 170.0, 177.0, 171.0, 173.0, 171.0, 168.0, 175.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 68.0, 68.0, 68.0, 68.0, 67.0, 69.0, 69.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1542.3, "alertThreshold": 2.0}]} 18:17:06 INFO - Return code: 0 18:17:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:17:06 INFO - # TBPL SUCCESS # 18:17:06 INFO - Running post-action listener: _resource_record_post_action 18:17:06 INFO - [mozharness: 2016-08-17 01:17:06.731350Z] Finished run-tests step (success) 18:17:06 INFO - Running post-run listener: _resource_record_post_run 18:17:06 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406700032; Read time: 16; Write time: 307800 18:17:06 INFO - TinderboxPrint: CPU usage
13.0% 18:17:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:17:06 INFO - TinderboxPrint: I/O write bytes / time
406,700,032 / 307,800 18:17:06 INFO - TinderboxPrint: CPU idle
8,343.3 (87.0%) 18:17:06 INFO - TinderboxPrint: CPU user
1,199.1 (12.5%) 18:17:06 INFO - TinderboxPrint: Swap in / out
0 / 0 18:17:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124567552; Read time: 0; Write time: 102876 18:17:06 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 282132480; Read time: 0; Write time: 204924 18:17:07 INFO - Running post-run listener: _upload_blobber_files 18:17:07 INFO - Blob upload gear active. 18:17:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:17:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:17:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:17:07 INFO - (blobuploader) - INFO - Open directory for files ... 18:17:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:17:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:17:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:17:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:17:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:17:12 INFO - (blobuploader) - INFO - Done attempting. 18:17:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:17:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:17:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:17:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:17:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:17:13 INFO - (blobuploader) - INFO - Done attempting. 18:17:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:17:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:17:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:17:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:17:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:17:14 INFO - (blobuploader) - INFO - Done attempting. 18:17:14 INFO - (blobuploader) - INFO - Iteration through files over. 18:17:14 INFO - Return code: 0 18:17:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:17:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:17:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aac9176b1a74ce8d52f66973a110620ffc44d5606c278969a2a30dcac20395be05ae51a3eed547a1765809917b04c43e0cf4c1a8290e9333ed1ab7aa209aa4ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/24a2067e4c8b9e1a8df6862d687b8042653881b5448f934ad3a23a0165ad41ce63bbd805d82957e464337259275d346c9d969b9792c63454a91482b0e9970f55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6cc7c3b8dbba0bc4d044841b47e382c03c8a0b94ad47ca69b9079bf705e943533b90cb5d940c857a35a09f466903dd303d096e4f9915a974e5d46b22a6429cbf"} 18:17:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:17:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:17:14 INFO - Contents: 18:17:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aac9176b1a74ce8d52f66973a110620ffc44d5606c278969a2a30dcac20395be05ae51a3eed547a1765809917b04c43e0cf4c1a8290e9333ed1ab7aa209aa4ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/24a2067e4c8b9e1a8df6862d687b8042653881b5448f934ad3a23a0165ad41ce63bbd805d82957e464337259275d346c9d969b9792c63454a91482b0e9970f55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6cc7c3b8dbba0bc4d044841b47e382c03c8a0b94ad47ca69b9079bf705e943533b90cb5d940c857a35a09f466903dd303d096e4f9915a974e5d46b22a6429cbf"} 18:17:14 INFO - Running post-run listener: copy_logs_to_upload_dir 18:17:14 INFO - Copying logs to upload dir... 18:17:14 INFO - mkdir: /builds/slave/test/build/upload/logs 18:17:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.914239 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-16 18:17:14.213630) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 18:17:14.216698) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aac9176b1a74ce8d52f66973a110620ffc44d5606c278969a2a30dcac20395be05ae51a3eed547a1765809917b04c43e0cf4c1a8290e9333ed1ab7aa209aa4ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/24a2067e4c8b9e1a8df6862d687b8042653881b5448f934ad3a23a0165ad41ce63bbd805d82957e464337259275d346c9d969b9792c63454a91482b0e9970f55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6cc7c3b8dbba0bc4d044841b47e382c03c8a0b94ad47ca69b9079bf705e943533b90cb5d940c857a35a09f466903dd303d096e4f9915a974e5d46b22a6429cbf"} build_url:https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/N2XqWX44SEiDeXdnC54eYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aac9176b1a74ce8d52f66973a110620ffc44d5606c278969a2a30dcac20395be05ae51a3eed547a1765809917b04c43e0cf4c1a8290e9333ed1ab7aa209aa4ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/24a2067e4c8b9e1a8df6862d687b8042653881b5448f934ad3a23a0165ad41ce63bbd805d82957e464337259275d346c9d969b9792c63454a91482b0e9970f55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6cc7c3b8dbba0bc4d044841b47e382c03c8a0b94ad47ca69b9079bf705e943533b90cb5d940c857a35a09f466903dd303d096e4f9915a974e5d46b22a6429cbf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 18:17:14.244825) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 18:17:14.245154) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1471393092.504078-2102160974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 18:17:14.329442) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 18:17:14.329758) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 18:17:14.330055) ========= ========= Total master_lag: 0.16 =========