builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1479432176.58 results: success (0) buildid: 20161117160328 builduid: 0778fcb14960448b8894890eb7f166f3 revision: 3b448dd675a98845fa53b5b4144066d67e292bbd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 17:22:56.577995) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 17:22:56.578988) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 17:22:56.579723) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 17:22:56.596583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 17:22:56.597273) ========= 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=20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-17 17:22:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 114M=0s 2016-11-17 17:22:56 (114 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108110 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 17:22:56.720934) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 17:22:56.721303) ========= 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=20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014289 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 17:22:56.773739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-17 17:22:56.774560) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 3b448dd675a98845fa53b5b4144066d67e292bbd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 3b448dd675a98845fa53b5b4144066d67e292bbd --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=20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-17 17:22:57,099 truncating revision to first 12 chars 2016-11-17 17:22:57,099 Setting DEBUG logging. 2016-11-17 17:22:57,099 attempt 1/10 2016-11-17 17:22:57,099 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/3b448dd675a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 17:22:58,534 unpacking tar archive at: graphics-3b448dd675a9/testing/mozharness/ program finished with exit code 0 elapsedTime=2.155357 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-17 17:22:58.945451) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 17:22:58.945817) ========= script_repo_revision: 3b448dd675a98845fa53b5b4144066d67e292bbd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 17:22:58.946274) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 17:22:58.946582) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 17:22:58.956256) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-17 17:22:58.956672) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:22:59 INFO - MultiFileLogger online at 20161117 17:22:59 in /builds/slave/test 17:22:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 17:22:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:22:59 INFO - {'append_to_log': False, 17:22:59 INFO - 'base_work_dir': '/builds/slave/test', 17:22:59 INFO - 'blob_upload_branch': 'Graphics', 17:22:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:22:59 INFO - 'branch': 'Graphics', 17:22:59 INFO - 'buildbot_json_path': 'buildprops.json', 17:22:59 INFO - 'config_files': ('talos/linux_config.py',), 17:22:59 INFO - 'default_actions': ('clobber', 17:22:59 INFO - 'read-buildbot-config', 17:22:59 INFO - 'download-and-extract', 17:22:59 INFO - 'populate-webroot', 17:22:59 INFO - 'create-virtualenv', 17:22:59 INFO - 'install', 17:22:59 INFO - 'run-tests'), 17:22:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:22:59 INFO - 'download_minidump_stackwalk': True, 17:22:59 INFO - 'download_symbols': 'ondemand', 17:22:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:22:59 INFO - 'tooltool.py': '/tools/tooltool.py', 17:22:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:22:59 INFO - '/tools/misc-python/virtualenv.py')}, 17:22:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:22:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:22:59 INFO - 'installer_path': 'installer.exe', 17:22:59 INFO - 'log_level': 'info', 17:22:59 INFO - 'log_name': 'talos', 17:22:59 INFO - 'log_to_console': True, 17:22:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:22:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:22:59 INFO - 'opt_config_files': (), 17:22:59 INFO - 'pip_index': False, 17:22:59 INFO - 'sps_profile': False, 17:22:59 INFO - 'sps_profile_interval': 0, 17:22:59 INFO - 'suite': 'dromaeojs-e10s', 17:22:59 INFO - 'system_bits': '32', 17:22:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:22:59 INFO - 'title': 'talos-linux64-ix-015', 17:22:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:22:59 INFO - 'use_talos_json': True, 17:22:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:22:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:22:59 INFO - 'work_dir': 'build'} 17:22:59 INFO - [mozharness: 2016-11-18 01:22:59.377476Z] Running clobber step. 17:22:59 INFO - Running pre-action listener: _resource_record_pre_action 17:22:59 INFO - Running main action method: clobber 17:22:59 INFO - rmtree: /builds/slave/test/build 17:22:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:22:59 INFO - Running post-action listener: _resource_record_post_action 17:22:59 INFO - [mozharness: 2016-11-18 01:22:59.836855Z] Finished clobber step (success) 17:22:59 INFO - [mozharness: 2016-11-18 01:22:59.836953Z] Running read-buildbot-config step. 17:22:59 INFO - Running pre-action listener: _resource_record_pre_action 17:22:59 INFO - Running main action method: read_buildbot_config 17:22:59 INFO - Using buildbot properties: 17:22:59 INFO - { 17:22:59 INFO - "project": "", 17:22:59 INFO - "product": "firefox", 17:22:59 INFO - "script_repo_revision": "default", 17:22:59 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 17:22:59 INFO - "repository": "", 17:22:59 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 17:22:59 INFO - "buildid": "20161117160328", 17:22:59 INFO - "pgo_build": "False", 17:22:59 INFO - "basedir": "/builds/slave/test", 17:22:59 INFO - "buildnumber": 6, 17:22:59 INFO - "slavename": "talos-linux64-ix-015", 17:22:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:22:59 INFO - "platform": "ubuntu64_hw", 17:22:59 INFO - "scheduler": "tests-graphics-linux64-talos", 17:22:59 INFO - "branch": "graphics", 17:22:59 INFO - "repo_path": "projects/graphics", 17:22:59 INFO - "revision": "3b448dd675a98845fa53b5b4144066d67e292bbd", 17:22:59 INFO - "stage_platform": "linux64", 17:22:59 INFO - "builduid": "0778fcb14960448b8894890eb7f166f3", 17:22:59 INFO - "slavebuilddir": "test" 17:22:59 INFO - } 17:22:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 17:22:59 INFO - Running post-action listener: _resource_record_post_action 17:22:59 INFO - [mozharness: 2016-11-18 01:22:59.839394Z] Finished read-buildbot-config step (success) 17:22:59 INFO - [mozharness: 2016-11-18 01:22:59.839482Z] Running download-and-extract step. 17:22:59 INFO - Running pre-action listener: _resource_record_pre_action 17:22:59 INFO - Running main action method: download_and_extract 17:22:59 INFO - mkdir: /builds/slave/test/build/tests 17:22:59 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:22:59 INFO - trying https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:22:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:22:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:23:00 INFO - Downloaded 1361 bytes. 17:23:00 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:23:00 INFO - Using the following test package requirements: 17:23:00 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 17:23:00 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:23:00 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:23:00 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:00 INFO - u'jsshell-linux-x86_64.zip'], 17:23:00 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:23:00 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 17:23:00 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:23:00 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:23:00 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:23:00 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:23:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:23:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:23:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 17:23:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:23:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:23:00 INFO - Http code: 200 17:23:00 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 17:23:00 INFO - x-amz-cf-id: DXGcEHIiRSu8Xk6Y4nGHAMxhvUgaer2qC5tl1Z2UXr3bbA_xKD2Hgg== 17:23:00 INFO - x-amz-version-id: tFft4Y.INJyaDF_sel9jqH6083S6eRYa 17:23:01 INFO - Expected file size: 20361480 17:23:01 INFO - Obtained file size: 20361480 17:23:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:23:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 17:23:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:23:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:23:05 INFO - Http code: 200 17:23:05 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 17:23:05 INFO - x-amz-cf-id: dbQXO1SkaQTu4EZixrz6SypC7V5o0hRoKsj8Wf2zOeBGquyPvuv4FQ== 17:23:05 INFO - x-amz-version-id: tFft4Y.INJyaDF_sel9jqH6083S6eRYa 17:23:06 INFO - Expected file size: 20361480 17:23:06 INFO - Obtained file size: 20361480 17:23:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 17:23:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:23:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:23:11 INFO - Http code: 200 17:23:11 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 17:23:11 INFO - x-amz-cf-id: SnlvT_ZIVD20450IxQxi-34cJZyKnaHGU0zD15P26vtInPuW_FHqJA== 17:23:11 INFO - x-amz-version-id: 0T_RqRb_dwS2oXtTrsmwU3StHHmaVEPT 17:23:12 INFO - Expected file size: 14409392 17:23:12 INFO - Obtained file size: 14409392 17:23:12 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:23:12 INFO - trying https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:23:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:23:13 INFO - Downloaded 55729201 bytes. 17:23:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:23:13 INFO - mkdir: /builds/slave/test/properties 17:23:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:23:13 INFO - Writing to file /builds/slave/test/properties/build_url 17:23:13 INFO - Contents: 17:23:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:23:14 INFO - Running post-action listener: _resource_record_post_action 17:23:14 INFO - Running post-action listener: set_extra_try_arguments 17:23:14 INFO - [mozharness: 2016-11-18 01:23:14.119515Z] Finished download-and-extract step (success) 17:23:14 INFO - [mozharness: 2016-11-18 01:23:14.119814Z] Running populate-webroot step. 17:23:14 INFO - Running pre-action listener: _resource_record_pre_action 17:23:14 INFO - Running main action method: populate_webroot 17:23:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:23:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:23:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:23:14 INFO - '--tppagecycles', 17:23:14 INFO - '7'], 17:23:14 INFO - 'tests': ['tsvgm']}}, 17:23:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:23:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:23:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:23:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:23:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:23:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:23:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:23:14 INFO - 'talos_options': ['--disable-e10s'], 17:23:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:23:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:23:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:23:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:23:14 INFO - 'talos_options': ['--disable-e10s'], 17:23:14 INFO - 'tests': ['damp', 'tps']}, 17:23:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:23:14 INFO - 'tests': ['damp', 'tps']}, 17:23:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:23:14 INFO - 'tests': ['dromaeo_dom']}, 17:23:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:23:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:23:14 INFO - 'tests': ['basic_compositor_video']}, 17:23:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:23:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:23:14 INFO - 'tests': ['a11yr', 17:23:14 INFO - 'ts_paint', 17:23:14 INFO - 'tpaint', 17:23:14 INFO - 'sessionrestore', 17:23:14 INFO - 'sessionrestore_no_auto_restore', 17:23:14 INFO - 'tabpaint']}, 17:23:14 INFO - 'other-e10s': {'tests': ['a11yr', 17:23:14 INFO - 'ts_paint', 17:23:14 INFO - 'tpaint', 17:23:14 INFO - 'sessionrestore', 17:23:14 INFO - 'sessionrestore_no_auto_restore', 17:23:14 INFO - 'tabpaint']}, 17:23:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:23:14 INFO - 'ts_paint', 17:23:14 INFO - 'tpaint', 17:23:14 INFO - 'sessionrestore', 17:23:14 INFO - 'sessionrestore_no_auto_restore', 17:23:14 INFO - 'tabpaint']}, 17:23:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:23:14 INFO - 'ts_paint', 17:23:14 INFO - 'tpaint', 17:23:14 INFO - 'sessionrestore', 17:23:14 INFO - 'sessionrestore_no_auto_restore', 17:23:14 INFO - 'tabpaint']}, 17:23:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:23:14 INFO - 'tests': ['a11yr', 17:23:14 INFO - 'ts_paint', 17:23:14 INFO - 'tpaint', 17:23:14 INFO - 'sessionrestore', 17:23:14 INFO - 'sessionrestore_no_auto_restore', 17:23:14 INFO - 'tabpaint']}, 17:23:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:23:14 INFO - 'tests': ['a11yr', 17:23:14 INFO - 'ts_paint', 17:23:14 INFO - 'tpaint', 17:23:14 INFO - 'sessionrestore', 17:23:14 INFO - 'sessionrestore_no_auto_restore', 17:23:14 INFO - 'tabpaint']}, 17:23:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:23:14 INFO - 'tests': ['tsvgx', 17:23:14 INFO - 'tsvgr_opacity', 17:23:14 INFO - 'tart', 17:23:14 INFO - 'tscrollx', 17:23:14 INFO - 'cart']}, 17:23:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:23:14 INFO - 'tsvgr_opacity', 17:23:14 INFO - 'tart', 17:23:14 INFO - 'tscrollx', 17:23:14 INFO - 'cart']}, 17:23:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:23:14 INFO - 'talos_options': ['--disable-e10s'], 17:23:14 INFO - 'tests': ['tp5o']}, 17:23:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:23:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:23:14 INFO - 'talos_options': ['--disable-e10s', 17:23:14 INFO - '--xperf_path', 17:23:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:23:14 INFO - 'tests': ['tp5n']}, 17:23:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:23:14 INFO - 'talos_options': ['--xperf_path', 17:23:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:23:14 INFO - 'tests': ['tp5n']}}, 17:23:14 INFO - 'talos.zip': {'path': '', 17:23:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:23:14 INFO - Running post-action listener: _resource_record_post_action 17:23:14 INFO - [mozharness: 2016-11-18 01:23:14.135169Z] Finished populate-webroot step (success) 17:23:14 INFO - [mozharness: 2016-11-18 01:23:14.135257Z] Running create-virtualenv step. 17:23:14 INFO - Running pre-action listener: _resource_record_pre_action 17:23:14 INFO - Running main action method: create_virtualenv 17:23:14 INFO - Creating virtualenv /builds/slave/test/build/venv 17:23:14 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:23:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:23:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:23:14 INFO - Using real prefix '/usr' 17:23:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:23:14 INFO - Installing distribute.............................................................................................................................................................................................done. 17:23:16 INFO - Installing pip.................done. 17:23:16 INFO - Return code: 0 17:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:23:16 INFO - Reading from file tmpfile_stdout 17:23:16 INFO - Output received: 17:23:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:23:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:23:16 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:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:16 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:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:16 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 0x7f9e0443ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b96130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c24fc0>, '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 0x2c25ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', '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:23:16 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:23:16 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:23:16 INFO - Using env: {'DISPLAY': ':0', 17:23:16 INFO - 'HOME': '/home/cltbld', 17:23:16 INFO - 'LANG': 'en_US.UTF-8', 17:23:16 INFO - 'LANGUAGE': 'en_US:en', 17:23:16 INFO - 'LOGNAME': 'cltbld', 17:23:16 INFO - 'MAIL': '/var/mail/cltbld', 17:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:16 INFO - 'MOZ_NO_REMOTE': '1', 17:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:16 INFO - 'NO_EM_RESTART': '1', 17:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:16 INFO - 'PWD': '/builds/slave/test', 17:23:16 INFO - 'SHELL': '/bin/bash', 17:23:16 INFO - 'SHLVL': '1', 17:23:16 INFO - 'TERM': 'linux', 17:23:16 INFO - 'TMOUT': '86400', 17:23:16 INFO - 'USER': 'cltbld', 17:23:16 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', 17:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:16 INFO - '_': '/tools/buildbot/bin/python'} 17:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:17 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:23:17 INFO - Cleaning up... 17:23:17 INFO - Return code: 0 17:23:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:23:17 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:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:17 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:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:17 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 0x7f9e0443ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b96130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c24fc0>, '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 0x2c25ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', '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:23:17 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:23:17 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:23:17 INFO - Using env: {'DISPLAY': ':0', 17:23:17 INFO - 'HOME': '/home/cltbld', 17:23:17 INFO - 'LANG': 'en_US.UTF-8', 17:23:17 INFO - 'LANGUAGE': 'en_US:en', 17:23:17 INFO - 'LOGNAME': 'cltbld', 17:23:17 INFO - 'MAIL': '/var/mail/cltbld', 17:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:17 INFO - 'MOZ_NO_REMOTE': '1', 17:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:17 INFO - 'NO_EM_RESTART': '1', 17:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:17 INFO - 'PWD': '/builds/slave/test', 17:23:17 INFO - 'SHELL': '/bin/bash', 17:23:17 INFO - 'SHLVL': '1', 17:23:17 INFO - 'TERM': 'linux', 17:23:17 INFO - 'TMOUT': '86400', 17:23:17 INFO - 'USER': 'cltbld', 17:23:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', 17:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:17 INFO - '_': '/tools/buildbot/bin/python'} 17:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:17 INFO - Downloading/unpacking psutil>=3.1.1 17:23:17 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:23:17 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:23:17 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:23:17 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:23:17 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:23:17 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:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:23:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:23:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:23:19 INFO - Installing collected packages: psutil 17:23:19 INFO - Running setup.py install for psutil 17:23:19 INFO - building 'psutil._psutil_linux' extension 17:23:19 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:23:19 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:23:19 INFO - building 'psutil._psutil_posix' extension 17:23:19 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:23:19 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:23:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:23:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:23:19 INFO - Successfully installed psutil 17:23:19 INFO - Cleaning up... 17:23:19 INFO - Return code: 0 17:23:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:23:19 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:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:19 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:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:19 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 0x7f9e0443ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b96130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c24fc0>, '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 0x2c25ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', '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:23:19 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:23:19 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:23:19 INFO - Using env: {'DISPLAY': ':0', 17:23:19 INFO - 'HOME': '/home/cltbld', 17:23:19 INFO - 'LANG': 'en_US.UTF-8', 17:23:19 INFO - 'LANGUAGE': 'en_US:en', 17:23:19 INFO - 'LOGNAME': 'cltbld', 17:23:19 INFO - 'MAIL': '/var/mail/cltbld', 17:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:19 INFO - 'MOZ_NO_REMOTE': '1', 17:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:19 INFO - 'NO_EM_RESTART': '1', 17:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:19 INFO - 'PWD': '/builds/slave/test', 17:23:19 INFO - 'SHELL': '/bin/bash', 17:23:19 INFO - 'SHLVL': '1', 17:23:19 INFO - 'TERM': 'linux', 17:23:19 INFO - 'TMOUT': '86400', 17:23:19 INFO - 'USER': 'cltbld', 17:23:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', 17:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:19 INFO - '_': '/tools/buildbot/bin/python'} 17:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:23:20 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:23:20 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:23:20 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:23:20 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:23:20 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:23:20 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:23:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:23:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:23:22 INFO - Installing collected packages: mozsystemmonitor 17:23:22 INFO - Running setup.py install for mozsystemmonitor 17:23:22 INFO - Successfully installed mozsystemmonitor 17:23:22 INFO - Cleaning up... 17:23:22 INFO - Return code: 0 17:23:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:23:22 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:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:22 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:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:22 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 0x7f9e0443ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b96130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c24fc0>, '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 0x2c25ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', '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:23:22 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:23:22 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:23:22 INFO - Using env: {'DISPLAY': ':0', 17:23:22 INFO - 'HOME': '/home/cltbld', 17:23:22 INFO - 'LANG': 'en_US.UTF-8', 17:23:22 INFO - 'LANGUAGE': 'en_US:en', 17:23:22 INFO - 'LOGNAME': 'cltbld', 17:23:22 INFO - 'MAIL': '/var/mail/cltbld', 17:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:22 INFO - 'MOZ_NO_REMOTE': '1', 17:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:22 INFO - 'NO_EM_RESTART': '1', 17:23:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:22 INFO - 'PWD': '/builds/slave/test', 17:23:22 INFO - 'SHELL': '/bin/bash', 17:23:22 INFO - 'SHLVL': '1', 17:23:22 INFO - 'TERM': 'linux', 17:23:22 INFO - 'TMOUT': '86400', 17:23:22 INFO - 'USER': 'cltbld', 17:23:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', 17:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:22 INFO - '_': '/tools/buildbot/bin/python'} 17:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:22 INFO - Downloading/unpacking jsonschema==2.5.1 17:23:22 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:23:22 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:23:22 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:23:22 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:23:22 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:23:22 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:23:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:23:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:23:24 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:23:24 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:23:24 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:23:24 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:23:24 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:23:24 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:23:24 INFO - Downloading functools32-3.2.3-2.tar.gz 17:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:23:24 INFO - warning: no files found matching '*.txt' 17:23:24 INFO - no previously-included directories found matching 'build' 17:23:24 INFO - no previously-included directories found matching 'dist' 17:23:24 INFO - no previously-included directories found matching '.git*' 17:23:24 INFO - Installing collected packages: jsonschema, functools32 17:23:24 INFO - Running setup.py install for functools32 17:23:24 INFO - warning: no files found matching '*.txt' 17:23:24 INFO - no previously-included directories found matching 'build' 17:23:24 INFO - no previously-included directories found matching 'dist' 17:23:24 INFO - no previously-included directories found matching '.git*' 17:23:24 INFO - Successfully installed jsonschema functools32 17:23:24 INFO - Cleaning up... 17:23:24 INFO - Return code: 0 17:23:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:23:24 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:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:24 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:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:24 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 0x7f9e0443ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b96130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c24fc0>, '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 0x2c25ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', '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:23:24 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:23:24 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:23:24 INFO - Using env: {'DISPLAY': ':0', 17:23:24 INFO - 'HOME': '/home/cltbld', 17:23:24 INFO - 'LANG': 'en_US.UTF-8', 17:23:24 INFO - 'LANGUAGE': 'en_US:en', 17:23:24 INFO - 'LOGNAME': 'cltbld', 17:23:24 INFO - 'MAIL': '/var/mail/cltbld', 17:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:24 INFO - 'MOZ_NO_REMOTE': '1', 17:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:24 INFO - 'NO_EM_RESTART': '1', 17:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:24 INFO - 'PWD': '/builds/slave/test', 17:23:24 INFO - 'SHELL': '/bin/bash', 17:23:24 INFO - 'SHLVL': '1', 17:23:24 INFO - 'TERM': 'linux', 17:23:24 INFO - 'TMOUT': '86400', 17:23:24 INFO - 'USER': 'cltbld', 17:23:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', 17:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:24 INFO - '_': '/tools/buildbot/bin/python'} 17:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:23:25 INFO - Cleaning up... 17:23:25 INFO - Return code: 0 17:23:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:23:25 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:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:25 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:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:25 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 0x7f9e0443ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b96130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c24fc0>, '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 0x2c25ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', '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:23:25 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:23:25 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:23:25 INFO - Using env: {'DISPLAY': ':0', 17:23:25 INFO - 'HOME': '/home/cltbld', 17:23:25 INFO - 'LANG': 'en_US.UTF-8', 17:23:25 INFO - 'LANGUAGE': 'en_US:en', 17:23:25 INFO - 'LOGNAME': 'cltbld', 17:23:25 INFO - 'MAIL': '/var/mail/cltbld', 17:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:25 INFO - 'MOZ_NO_REMOTE': '1', 17:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:25 INFO - 'NO_EM_RESTART': '1', 17:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:25 INFO - 'PWD': '/builds/slave/test', 17:23:25 INFO - 'SHELL': '/bin/bash', 17:23:25 INFO - 'SHLVL': '1', 17:23:25 INFO - 'TERM': 'linux', 17:23:25 INFO - 'TMOUT': '86400', 17:23:25 INFO - 'USER': 'cltbld', 17:23:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', 17:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:25 INFO - '_': '/tools/buildbot/bin/python'} 17:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:25 INFO - Downloading/unpacking blobuploader==1.2.4 17:23:25 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:23:25 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:23:25 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:23:25 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:23:25 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:23:25 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:23:27 INFO - Downloading blobuploader-1.2.4.tar.gz 17:23:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:23:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:23:27 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:23:27 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:23:27 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:23:27 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:23:27 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:23:27 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:23:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:23:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:23:27 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:23:27 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:23:27 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:23:27 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:23:27 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:23:27 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:23:28 INFO - Downloading docopt-0.6.1.tar.gz 17:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:23:28 INFO - Installing collected packages: blobuploader, requests, docopt 17:23:28 INFO - Running setup.py install for blobuploader 17:23:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:23:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:23:28 INFO - Running setup.py install for requests 17:23:28 INFO - Running setup.py install for docopt 17:23:28 INFO - Successfully installed blobuploader requests docopt 17:23:28 INFO - Cleaning up... 17:23:28 INFO - Return code: 0 17:23:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:28 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:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:28 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:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:28 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 0x7f9e0443ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b96130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c24fc0>, '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 0x2c25ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', '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:23:28 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:23:28 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:23:28 INFO - Using env: {'DISPLAY': ':0', 17:23:28 INFO - 'HOME': '/home/cltbld', 17:23:28 INFO - 'LANG': 'en_US.UTF-8', 17:23:28 INFO - 'LANGUAGE': 'en_US:en', 17:23:28 INFO - 'LOGNAME': 'cltbld', 17:23:28 INFO - 'MAIL': '/var/mail/cltbld', 17:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:28 INFO - 'MOZ_NO_REMOTE': '1', 17:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:28 INFO - 'NO_EM_RESTART': '1', 17:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:28 INFO - 'PWD': '/builds/slave/test', 17:23:28 INFO - 'SHELL': '/bin/bash', 17:23:28 INFO - 'SHLVL': '1', 17:23:28 INFO - 'TERM': 'linux', 17:23:28 INFO - 'TMOUT': '86400', 17:23:28 INFO - 'USER': 'cltbld', 17:23:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', 17:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:28 INFO - '_': '/tools/buildbot/bin/python'} 17:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:23:29 INFO - Running setup.py (path:/tmp/pip-di9iZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:23:29 INFO - Running setup.py (path:/tmp/pip-uwv7dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:23:29 INFO - Running setup.py (path:/tmp/pip-vJ49Li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:23:29 INFO - Running setup.py (path:/tmp/pip-T1vuPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:23:29 INFO - Running setup.py (path:/tmp/pip-R9qQTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:23:29 INFO - Running setup.py (path:/tmp/pip-dV5zXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:23:29 INFO - Running setup.py (path:/tmp/pip-gkipH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:23:29 INFO - Running setup.py (path:/tmp/pip-xK2HeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:23:29 INFO - Running setup.py (path:/tmp/pip-L_hlsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:23:29 INFO - Running setup.py (path:/tmp/pip-9cgEFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:23:29 INFO - Running setup.py (path:/tmp/pip-0iwNBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:23:29 INFO - Running setup.py (path:/tmp/pip-sHuIDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:23:29 INFO - Running setup.py (path:/tmp/pip-jiXLJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:23:30 INFO - Running setup.py (path:/tmp/pip-zBoB2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:30 INFO - Running setup.py (path:/tmp/pip-pjgC4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:23:30 INFO - Running setup.py (path:/tmp/pip-ThDNJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:23:30 INFO - Running setup.py (path:/tmp/pip-xOYJGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:23:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:23:30 INFO - Running setup.py install for manifestparser 17:23:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:23:30 INFO - Running setup.py install for mozcrash 17:23:30 INFO - Running setup.py install for mozdebug 17:23:30 INFO - Running setup.py install for mozdevice 17:23:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:23:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:23:30 INFO - Running setup.py install for mozfile 17:23:30 INFO - Running setup.py install for mozhttpd 17:23:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:23:30 INFO - Running setup.py install for mozinfo 17:23:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:23:31 INFO - Running setup.py install for mozInstall 17:23:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:23:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:23:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:23:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:23:31 INFO - Running setup.py install for mozleak 17:23:31 INFO - Running setup.py install for mozlog 17:23:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:23:31 INFO - Running setup.py install for moznetwork 17:23:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:23:31 INFO - Running setup.py install for mozprocess 17:23:31 INFO - Running setup.py install for mozprofile 17:23:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:23:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:23:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:23:31 INFO - Running setup.py install for mozrunner 17:23:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:23:31 INFO - Running setup.py install for mozscreenshot 17:23:31 INFO - Running setup.py install for moztest 17:23:31 INFO - Running setup.py install for mozversion 17:23:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:23:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:23:32 INFO - Cleaning up... 17:23:32 INFO - Return code: 0 17:23:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:32 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:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:32 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:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:32 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 0x7f9e0443ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b96130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c24fc0>, '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 0x2c25ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', '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:23:32 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:23:32 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:23:32 INFO - Using env: {'DISPLAY': ':0', 17:23:32 INFO - 'HOME': '/home/cltbld', 17:23:32 INFO - 'LANG': 'en_US.UTF-8', 17:23:32 INFO - 'LANGUAGE': 'en_US:en', 17:23:32 INFO - 'LOGNAME': 'cltbld', 17:23:32 INFO - 'MAIL': '/var/mail/cltbld', 17:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:32 INFO - 'MOZ_NO_REMOTE': '1', 17:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:32 INFO - 'NO_EM_RESTART': '1', 17:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:32 INFO - 'PWD': '/builds/slave/test', 17:23:32 INFO - 'SHELL': '/bin/bash', 17:23:32 INFO - 'SHLVL': '1', 17:23:32 INFO - 'TERM': 'linux', 17:23:32 INFO - 'TMOUT': '86400', 17:23:32 INFO - 'USER': 'cltbld', 17:23:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', 17:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:32 INFO - '_': '/tools/buildbot/bin/python'} 17:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:23:32 INFO - Running setup.py (path:/tmp/pip-Scns6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:23:32 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:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:23:32 INFO - Running setup.py (path:/tmp/pip-QcEO54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:23:32 INFO - Running setup.py (path:/tmp/pip-qII1Uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:23:32 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:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:23:32 INFO - Running setup.py (path:/tmp/pip-iVgIj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:23:32 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:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:23:32 INFO - Running setup.py (path:/tmp/pip-zG0MEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:23:32 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:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:23:32 INFO - Running setup.py (path:/tmp/pip-sgdOvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:23:32 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:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:23:32 INFO - Running setup.py (path:/tmp/pip-M2L_FG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:23:32 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:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:23:32 INFO - Running setup.py (path:/tmp/pip-5C9ohr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:23:32 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:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:23:32 INFO - Running setup.py (path:/tmp/pip-bR7h7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:23:32 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:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:23:32 INFO - Running setup.py (path:/tmp/pip-8mVHvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:23:33 INFO - Running setup.py (path:/tmp/pip-hlZRZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:23:33 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:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:23:33 INFO - Running setup.py (path:/tmp/pip-v1OQWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:23:33 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:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:23:33 INFO - Running setup.py (path:/tmp/pip-82Yn0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:23:33 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:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:23:33 INFO - Running setup.py (path:/tmp/pip-qFHlDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:33 INFO - Running setup.py (path:/tmp/pip-GsQRqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:33 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:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:23:33 INFO - Running setup.py (path:/tmp/pip-xzYMhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:23:33 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:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:23:33 INFO - Running setup.py (path:/tmp/pip-BBGSQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:23:33 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:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:23:33 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:23:33 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:23:33 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:23:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:23:33 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:23:33 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:23:33 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:23:33 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:23:33 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:23:33 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:23:35 INFO - Downloading blessings-1.6.tar.gz 17:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:23:35 INFO - Installing collected packages: blessings 17:23:35 INFO - Running setup.py install for blessings 17:23:35 INFO - Successfully installed blessings 17:23:35 INFO - Cleaning up... 17:23:35 INFO - Return code: 0 17:23:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:23:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:23:35 INFO - Reading from file tmpfile_stdout 17:23:35 INFO - Current package versions: 17:23:35 INFO - argparse == 1.2.1 17:23:35 INFO - blessings == 1.6 17:23:35 INFO - blobuploader == 1.2.4 17:23:35 INFO - docopt == 0.6.1 17:23:35 INFO - functools32 == 3.2.3-2 17:23:35 INFO - jsonschema == 2.5.1 17:23:35 INFO - manifestparser == 1.1 17:23:35 INFO - mozInstall == 1.12 17:23:35 INFO - mozcrash == 1.0 17:23:35 INFO - mozdebug == 0.1 17:23:35 INFO - mozdevice == 0.48 17:23:35 INFO - mozfile == 1.2 17:23:35 INFO - mozhttpd == 0.7 17:23:35 INFO - mozinfo == 0.9 17:23:35 INFO - mozleak == 0.1 17:23:35 INFO - mozlog == 3.4 17:23:35 INFO - moznetwork == 0.27 17:23:35 INFO - mozprocess == 0.23 17:23:35 INFO - mozprofile == 0.28 17:23:35 INFO - mozrunner == 6.13 17:23:35 INFO - mozscreenshot == 0.1 17:23:35 INFO - mozsystemmonitor == 0.3 17:23:35 INFO - moztest == 0.7 17:23:35 INFO - mozversion == 1.4 17:23:35 INFO - psutil == 3.1.1 17:23:35 INFO - requests == 1.2.3 17:23:35 INFO - wsgiref == 0.1.2 17:23:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23: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:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23: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:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:35 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 0x7f9e0443ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b96130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c24fc0>, '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 0x2c25ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', '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:23:35 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:23:35 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:23:35 INFO - Using env: {'DISPLAY': ':0', 17:23:35 INFO - 'HOME': '/home/cltbld', 17:23:35 INFO - 'LANG': 'en_US.UTF-8', 17:23:35 INFO - 'LANGUAGE': 'en_US:en', 17:23:35 INFO - 'LOGNAME': 'cltbld', 17:23:35 INFO - 'MAIL': '/var/mail/cltbld', 17:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:35 INFO - 'MOZ_NO_REMOTE': '1', 17:23:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:35 INFO - 'NO_EM_RESTART': '1', 17:23:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:35 INFO - 'PWD': '/builds/slave/test', 17:23:35 INFO - 'SHELL': '/bin/bash', 17:23:35 INFO - 'SHLVL': '1', 17:23:35 INFO - 'TERM': 'linux', 17:23:35 INFO - 'TMOUT': '86400', 17:23:35 INFO - 'USER': 'cltbld', 17:23:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', 17:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:35 INFO - '_': '/tools/buildbot/bin/python'} 17:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:36 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:23:36 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:23:36 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:23:36 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:23:36 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:23:36 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:23:36 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:23:36 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:23:36 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:23:36 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:23:36 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:23:36 INFO - Cleaning up... 17:23:36 INFO - Return code: 0 17:23:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:23:36 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:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:36 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:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:36 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 0x7f9e0443ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b96130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c24fc0>, '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 0x2c25ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', '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:23:36 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:23:36 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:23:36 INFO - Using env: {'DISPLAY': ':0', 17:23:36 INFO - 'HOME': '/home/cltbld', 17:23:36 INFO - 'LANG': 'en_US.UTF-8', 17:23:36 INFO - 'LANGUAGE': 'en_US:en', 17:23:36 INFO - 'LOGNAME': 'cltbld', 17:23:36 INFO - 'MAIL': '/var/mail/cltbld', 17:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:36 INFO - 'MOZ_NO_REMOTE': '1', 17:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:36 INFO - 'NO_EM_RESTART': '1', 17:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:36 INFO - 'PWD': '/builds/slave/test', 17:23:36 INFO - 'SHELL': '/bin/bash', 17:23:36 INFO - 'SHLVL': '1', 17:23:36 INFO - 'TERM': 'linux', 17:23:36 INFO - 'TMOUT': '86400', 17:23:36 INFO - 'USER': 'cltbld', 17:23:36 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', 17:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:36 INFO - '_': '/tools/buildbot/bin/python'} 17:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:23:36 INFO - Cleaning up... 17:23:36 INFO - Return code: 0 17:23:36 INFO - Running post-action listener: _resource_record_post_action 17:23:36 INFO - Running post-action listener: _start_resource_monitoring 17:23:36 INFO - Starting resource monitoring. 17:23:36 INFO - [mozharness: 2016-11-18 01:23:36.456094Z] Finished create-virtualenv step (success) 17:23:36 INFO - [mozharness: 2016-11-18 01:23:36.456610Z] Running install step. 17:23:36 INFO - Running pre-action listener: _resource_record_pre_action 17:23:36 INFO - Running main action method: install 17:23:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:23:36 INFO - Reading from file tmpfile_stdout 17:23:36 INFO - Detecting whether we're running mozinstall >=1.0... 17:23:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:23:36 INFO - Reading from file tmpfile_stdout 17:23:36 INFO - Output received: 17:23:36 INFO - Usage: mozinstall [options] installer 17:23:36 INFO - Options: 17:23:36 INFO - -h, --help show this help message and exit 17:23:36 INFO - -d DEST, --destination=DEST 17:23:36 INFO - Directory to install application into. [default: 17:23:36 INFO - "/builds/slave/test"] 17:23:36 INFO - --app=APP Application being installed. [default: firefox] 17:23:36 INFO - mkdir: /builds/slave/test/build/application 17:23:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:23:52 INFO - Reading from file tmpfile_stdout 17:23:52 INFO - Output received: 17:23:52 INFO - /builds/slave/test/build/application/firefox/firefox 17:23:52 INFO - Running post-action listener: _resource_record_post_action 17:23:52 INFO - [mozharness: 2016-11-18 01:23:52.808384Z] Finished install step (success) 17:23:52 INFO - [mozharness: 2016-11-18 01:23:52.808638Z] Running run-tests step. 17:23:52 INFO - Running pre-action listener: _resource_record_pre_action 17:23:52 INFO - Running main action method: run_tests 17:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:23:52 INFO - Python 2.7.3 17:23:52 INFO - Return code: 0 17:23:52 INFO - grabbing minidump binary from tooltool 17:23:52 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:23:52 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 0x2c24fc0>, '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 0x2c25ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:23:52 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:23:52 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:23:52 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:23:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:23:52 INFO - Return code: 0 17:23:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:23:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:23:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:23:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:23:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:23:52 INFO - Using env: {'DISPLAY': ':0', 17:23:52 INFO - 'HOME': '/home/cltbld', 17:23:52 INFO - 'LANG': 'en_US.UTF-8', 17:23:52 INFO - 'LANGUAGE': 'en_US:en', 17:23:52 INFO - 'LOGNAME': 'cltbld', 17:23:52 INFO - 'MAIL': '/var/mail/cltbld', 17:23:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:23:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:52 INFO - 'MOZ_NO_REMOTE': '1', 17:23:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:52 INFO - 'NO_EM_RESTART': '1', 17:23:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:52 INFO - 'PWD': '/builds/slave/test', 17:23:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:23:52 INFO - 'SHELL': '/bin/bash', 17:23:52 INFO - 'SHLVL': '1', 17:23:52 INFO - 'TERM': 'linux', 17:23:52 INFO - 'TMOUT': '86400', 17:23:52 INFO - 'USER': 'cltbld', 17:23:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928', 17:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:52 INFO - '_': '/tools/buildbot/bin/python'} 17:23:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:23:53 INFO - mozversion application_buildid: 20161117160328 17:23:53 INFO - mozversion application_changeset: 3b448dd675a98845fa53b5b4144066d67e292bbd 17:23:53 INFO - mozversion application_display_name: Nightly 17:23:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:23:53 INFO - mozversion application_name: Firefox 17:23:53 INFO - mozversion application_remotingname: firefox 17:23:53 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 17:23:53 INFO - mozversion application_vendor: Mozilla 17:23:53 INFO - mozversion application_version: 53.0a1 17:23:53 INFO - mozversion platform_buildid: 20161117160328 17:23:53 INFO - mozversion platform_changeset: 3b448dd675a98845fa53b5b4144066d67e292bbd 17:23:53 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 17:23:53 INFO - mozversion platform_version: 53.0a1 17:23:53 INFO - using testdate: 1479432233 17:23:53 INFO - actual date: 1479432233 17:23:53 INFO - starting webserver on 'localhost:48362' 17:23:53 INFO - SUITE-START | Running 2 tests 17:23:53 INFO - TEST-START | dromaeo_css 17:23:53 INFO - operating with platform_type : linux_ 17:23:53 INFO - Initialising browser for dromaeo_css test... 17:23:53 INFO - TEST-INFO | started process 5537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV8MnsY/profile http://localhost:48362/getInfo.html) 17:23:57 INFO - PROCESS | 5537 | __metrics Screen width/height:1600/1200 17:23:57 INFO - PROCESS | 5537 | colorDepth:24 17:23:57 INFO - PROCESS | 5537 | Browser inner width/height: 1024/697 17:23:57 INFO - PROCESS | 5537 | __metrics 17:23:58 ERROR - PROCESS | 5537 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 17:23:59 INFO - TEST-INFO | 5537: exit 0 17:23:59 INFO - Browser initialized. 17:23:59 INFO - Running cycle 1/1 for dromaeo_css test... 17:23:59 INFO - TEST-INFO | started process 5660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV8MnsY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:24:11 INFO - PROCESS | 5660 | RSS: Main: 187371520 17:24:11 INFO - PROCESS | 5660 | 17:25:01 INFO - PROCESS | 5660 | 1479432301284 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] 17:27:15 INFO - PROCESS | 5660 | Cycle 1(1): loaded http://localhost:48362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48362/tests/dromaeo/cssquery-ext.html) 17:27:16 INFO - PROCESS | 5660 | RSS: Main: 196743168 17:27:16 INFO - PROCESS | 5660 | 17:30:18 INFO - PROCESS | 5660 | Cycle 1(1): loaded http://localhost:48362/tests/dromaeo/cssquery-ext.html (next: http://localhost:48362/tests/dromaeo/cssquery-jquery.html) 17:30:19 INFO - PROCESS | 5660 | RSS: Main: 197279744 17:30:19 INFO - PROCESS | 5660 | 17:33:21 INFO - PROCESS | 5660 | Cycle 1(1): loaded http://localhost:48362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48362/tests/dromaeo/cssquery-mootools.html) 17:33:22 INFO - PROCESS | 5660 | RSS: Main: 199659520 17:33:22 INFO - PROCESS | 5660 | 17:36:24 INFO - PROCESS | 5660 | Cycle 1(1): loaded http://localhost:48362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48362/tests/dromaeo/cssquery-prototype.html) 17:36:25 INFO - PROCESS | 5660 | RSS: Main: 195665920 17:36:25 INFO - PROCESS | 5660 | 17:39:28 INFO - PROCESS | 5660 | Cycle 1(1): loaded http://localhost:48362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48362/tests/dromaeo/cssquery-yui.html) 17:39:28 INFO - PROCESS | 5660 | RSS: Main: 199135232 17:39:28 INFO - PROCESS | 5660 | 17:42:31 INFO - PROCESS | 5660 | Cycle 1(1): loaded http://localhost:48362/tests/dromaeo/cssquery-yui.html (next: http://localhost:48362/tests/dromaeo/cssquery-dojo.html) 17:42:31 INFO - PROCESS | 5660 | RSS: Main: 199352320 17:42:31 INFO - PROCESS | 5660 | 17:42:31 INFO - PROCESS | 5660 | __start_tp_report 17:42:31 INFO - PROCESS | 5660 | _x_x_mozilla_page_load 17:42:31 INFO - PROCESS | 5660 | _x_x_mozilla_page_load_details 17:42:31 INFO - PROCESS | 5660 | |i|pagename|runs| 17:42:31 INFO - PROCESS | 5660 | |0;dojo.html;2545.732698066703;2553.9233822985316;2563.602641590554;2589.0808762889174;2598.5712357461007;4423.57975992281;4570.794314255858;4583.472900616426;4585.51852055534;4615.469221039577;4477.21648711475;4526.230540808062;4564.1328147652;4565.657575681829;4641.489436162019;4104.774237416948;4147.1705658868195;4163.875083747493;4246.8725938221905;4279;3876.8449262029485;4274.722143060691;4340.066885619591;4341.45731783527;4343.087951530182;4101.52832424269;4264.637505812009;4266.31738921771;4268.445102136733;4332.025294308771;4126.484189476316;4134.875953721393;4149.232392007489;4189.07840275142;4210.768407737573;4095.5699651536456;4136.565660605654;4141.565135660772;4161.91676166478;4241.088166044285;4537.478190008158;4564.178447879381;4564.7032942858605;4569.063342014879;4601.792919318638;4812.831550895737;4860.902781944376;4869.172240719086;4881.8535443936735;4910.116179087763;4890.462049174588;4913.164761990471;4916.557509824133;4918.409790825088;4949.430815456232;4474.306482495218;4590.495045544987;4592.6555508337005;4596.908061838744;4651.558101980374;4896.020795840846;4924.9507504925205;4944.035912996931;4986.675866068694;4989.600831933437;4766.880827979328;4781.737004464788;4784.569388755029;4802.159622066124;4808.374911261513;4689.62483001359;4834.129856625841;4835.879103022453;4842.83050093245;4878.756062196947;4673.252279635242;4709.128811169944;4713.6936099153445;4800.4719480857075;4827.927581086286;4758.16732071893;4770.356001939763;4782.976085119552;4798.616110711135;4811.398575178103;4066.573009833925;4068.7558746475306;4069.8168582413864;4076.062505623723;4127.7936103194725;3505.298940211968;3512.648735126467;3570.1610121621397;3608.8376023079027;3637.8544858205373;4181.916361672749;4198.055437526532;4201.978990105091;4226.746395216235;4237.152569486115;4899.044686286211;4900.509949005071;4910.435299940553;4912.94371710084;4961.603071754251;4004.899877503086;4055.6147166019773;4060.0864805418546;4078.938815917764;4190.979045104755;4247.978760106242;4264.0832221072615;4265.040365917644;4279.507856596531;4283.378910058024;4415.580519850609;4419.580139886705;4421.270490369053;4431.446069241345;4431.601155895856;4768.666193366431;4770.0936822003705;4779.091972525209;4784.186688262934;4785.401824771903;4445.133199026159;4447.110577884371;4450.265706158577;4458.06380660065;4458.4426946631675;4756.429228492603;4768.737719425326;4797.184478638709;4810.783514741915;4818.831340903052;4774.665773395829;4781.856544303677;4846.588040016638;4879.853604391874;4921.26181072842;4753.928691069567;4758.16732071893;4765.428148622187;4772.117158325721;4797.472278049481;4620.561046700558;4655.2784318430695;4668.416447944007;4758.762061896822;4787.8563643090765;4533.795979181011;4580.67935244543;4625.838095666635;4646.279826626878;4714.976425117852;4760.262159365304;4764.404449443819;4771.594414474808;4774.546418090275;4804.759762011955;4438.755868427267;4660.114578230261;4680.040591678766;4682.578567928903;4684.812607495662 17:42:31 INFO - PROCESS | 5660 | |1;ext.html;538.5879801951505;540.4487422828715;541.9729013549321;549.6290004247135;560.1373884218305;26883.327916802064;28336.291592710168;28348.57477137842;28458.715412845864;29755.85122074392;27417.862910685468;27693.861530692368;27696.169114926535;27744.445111097815;27811.443771124566;5346.6791992480385;5469.945300546983;5482.725863706799;5494.36814766301;5501.752421141058;5483;5556.777728890839;5558.082916318803;5564.081926482146;5570.749316280777;5548.223248745179;5609.411011843759;5610.607257491977;5616.045272303698;5628.662280263197;5557.6109672322955;5582.49757521823;5617.691026993513;5618.690971996539;5623.775048998035;5572.275604171432;5621.269234999424;5625.493705566478;5631.465010823965;5634.211210430543;25414.36464088394;25483;25746.485070298488;25757.484850302888;25869;3001.2496875781053;3090.8311654656154;3157.952630710541;3285.65500622436;3345.2305969626877;17519.299228030864;17742.20160092786;17828.46514604564;18466.261349546003;18616.162272697624;2618.738126187385;2669.2125822882294;2707.2690373599216;2708.417690196617;2711.6745990481268;225049;226142;226337;226556.86721566287;226986.86506567526;50825.74587127041;51049;51078.744606276734;51116.23325650118;51271.48728512667;52896;52970.73514632479;52977.7351113242;53145;53230.73384633129;13534.458621655023;13788.103773254707;13809.447622095004;13813.723725525433;13816.171029738249;10255.230857685703;10353.327033742782;10410.843837342445;10411.53148108337;10412.32319899204;16242.593935151715;16548.75176872348;16756.916215418845;16837.242324095445;16877.746833797257;5758.3665796762325;5770.6249093808765;5850.707464626752;5946.375630558816;5978.432048955342;792.8810678398287;856.5588721808274;882.9028806831243;945.0596656326861;970.2868391732071;25483.617745733827;25954.22137335883;26754.866225669135;26883;27200.863995679894;939.9248060155171;945.1257586732245;953.7043516509904;955.5890966884167;1014.1177175856905;14195.929020355039;14435.85564144366;14575.271236438135;14744;14884.925575372054;306607;307250;309478;310765;311366;43139.13721725548;43337.78331108324;43388.34917476241;43458;43462.34806477906;1140.948657310423;1160.8316794064813;1174.5888938871326;1176.3823992404057;1179.7640471905654;24940.37649058788;26008.34979125537;26904.192874213804;26941;26973;40249.798751006056;40937.795311023256;42212;42342.57657423386;45672.77163614161;305852;308198;308919;309105;309559;22782.886085569466;22811;23105.537889241783;23126.884365578066;23148.884255578614;36036.45945310875;36048.27903441969;36224.456633149995;37545.62454375421;37830.243395131394;31609.683903160672;31769;31811.363772723955;31991.88028418994;32700.34599307953;32212.677873220968;32306;32387.19032024218;32562;32608;31939.201519961258;32588;32863.342733144724;33011.33977320488;33012.834935825165;27579.44841103207;30172.24569385783;30178.24554386158;30252.84873575618;30294.242643933198;23277;23686.407839804142;23700.407489812893;23943.401414964766;24000 17:42:31 INFO - PROCESS | 5660 | |2;jquery.html;334.144589849984;337.7078826814805;345.94810778383237;350.1089726645688;375.3075575563085;11265.43672816359;11999.280043197414;12249.020078393707;12281.078919081072;12308.384580770971;14085.295735213249;14851.554453366389;14961;15466.072035677838;15863.889527733063;3877.3990031545154;4129.380592911058;4134.441850350209;4142.2543942090415;4145.316022856225;3932.1152740633415;4008.719389642726;4048.6356227939477;4055.3511438169753;4142.64787493062;4025.315696331616;4025.657819085381;4033.9596604033877;4035.6771458283265;4041.0907545802106;3918.4122381642696;4018.437418761361;4020.3165461871554;4023.6982226333143;4033.5764744701823;3715.6284371562897;3745.6441638044344;3756.3426400379826;3757.5490941087246;3758.530183727034;15858.36566537337;16151.596210094724;16200.918995405065;16319.347226110942;16481.505554833373;1874.7281644161656;1930.4594713480249;1939.398786376228;2029.594081183769;2426.842255253403;10082.970606691424;10551.78896422075;10910.890891091147;11109.83335249972;11163.162762792823;1433.3621538415305;1439.287552661429;1445.9349329280208;1455.1341951538818;1463.5536161470748;42473.36289955653;45575.544244557794;64072.679636601984;64661.67669161671;66475.66762166159;9137.862932056025;9260.629574816932;9454.432734035843;9482.905170948341;9744.75638109053;12889.355532223351;12929.935350323189;13003.479860805463;13013.869861301455;13121.934390328179;6884.173899132136;7016.2632923543315;7023.508354415244;7173.5337203081635;7202.92797072033;6768.492363072789;6780.932190678129;6925.75759848413;7009.579425234502;7042.753503627348;5783.351744752809;5814.825555233349;5851.736671849691;5867.442592953663;5936.5844390892225;1696.3553849537097;1722.2422134260885;1739.8608111351061;1772.6011647379494;1775.112443778111;852.8166444214523;901.5086777706166;905.2712566383992;927.1933417926313;934.9439033658002;15003.17482538449;15709;16900.746488802677;17062.59078634085;17400.129993500275;793.8409921514537;842.4313588327855;844.2654890245526;844.9704260350982;846.7205822078699;8914.465132092095;9401.294902882311;9470.810583788285;9489.288303377274;9589.952050239845;377164;381617;381769;381793;384172;46720.766396167804;83402.58298708468;83738;84617;85699;910.7859652981545;929.4051806843626;943.3302355327656;944.5182956692137;952.6760901293593;14971.475998340005;15046.473373431878;15222.543323700307;15621.921890390475;15800.288986995383;36995;37264.813675931444;38379.2324153521;38631.80684096562;40207.798961005006;50722.49277507325;50975.49024509856;51438.74280628723;51880.740596296775;52898.73550632222;7037.296270372922;7155.964220178866;7249.347558719741;7387.039684840936;7449.329560339379;7388;10087.949560252151;11361.898048860656;11440.656780296604;11539.538418463168;9719.173870220828;9913;10093.89906100959;10288.588456461657;10480;9608.567614457226;10041.297109202285;10076.647317343857;10210.744731381776;10254.897451025692;10193.388396696222;10289.176865850864;10373.740656483647;10603.402166469265;10851.620193293196;6662.233843108104;6789.321067893171;6910.7581234656545;6940.993555934462;6991;7625.6949722010495;9927.900720992697;10202.806396624761;10275.588976440858;10466.63366782159 17:42:31 INFO - PROCESS | 5660 | |3;mootools.html;1313.120209459662;1340.1824886819038;1363.5772910397777;1595.2741502616311;1622.1889055472263;5543.501084902358;5808.651480911149;5841.7371218295175;6097.9695101524485;6235;6098.237720284965;6346.333634968331;6372.107904893319;6374.490040796737;6380.393862583059;1677.991610041948;1714.8799584029123;1717.081361471613;1723.689735847547;1730.0571188702188;1720.587059105812;1728.5592173995612;1734.0722713348362;1739.0522165419814;1807.864410169236;1752.447978886653;1766.8321509456582;1770.070712875744;1772.2025088710068;1774.3346245158066;1712.7002774514472;1729.161356741979;1739.5564131146602;1741.582020315128;1742.5730695979503;1746.1269365317341;1752.3603884582035;1761.3835157694832;1763.312308199803;1781.26967943144;6285.811425657192;6330.145430366933;6332.208473940757;6336.049592561153;6345.333739957284;4048.6153815387493;4178.39413285075;4179.665626749853;4185.874423767292;4186.518550366686;2268.750437451879;2358.5872472317446;2437.427204606916;2605.192390358995;2704.283364908301;789.2107892107892;793.5000949401898;795.5187111797395;799.7680672604996;801.5951944268165;8490.745277641681;8509.319254459628;8514.70198543048;8538.914610853873;8568.400211985163;3673.834677439468;3728.7203459740626;3805.7906815125434;3828.770273783582;3831.7317787755146;6979.930200697928;7003.789886303419;7012.403945664676;7017.508774385744;7060.223375428699;4008.1983603278877;4015.9397609035886;4025.0742329264435;4026.053877338823;4072.552019277877;3718.721095917817;3776.131489757371;3782.735208535376;3783.9243215135543;3790;2880.1935458071775;2933.867975941088;2981.8807247709847;2990.4766665833827;2997.970020299813;885.3183049052323;902.8600566912139;904.5386852705168;921.3550514639645;927.2165020557618;698.2528694297155;709.3615745828693;729.7154109897144;730.8757511223105;734.8897665350133;4495.123450927038;4507.391502147234;4531.84138555149;4584.739196720929;4766.046790641885;378.50226951558614;391.9353306704419;394.35522920025966;395.6162522353313;398.2870661515912;3054.5418187271644;3129.9530507042414;3168.920776980548;3171.888983885553;3239.8218098004836;7055.8236044098285;7227.674754636054;7578.204288549733;7583.090029196532;7598.278163574451;7355.77932662021;7464.402847772274;7677.424193185533;7748.457607967388;7952;6008.068749343859;6008.4592386684535;6229.0967809668255;6240.31356550779;6247.5939063960695;4237.237297286518;4305.332673435622;4358.564143585616;4453.732776033448;4495.7976891039325;7197.316254955771;7255.165655949633;7342.082239720035;7375.11498620169;7394.482386232912;7346.449016323691;7417.703291868264;7421.962890185515;7442.4418168636485;7523.924760752322;5633.267675202197;5656.490915817596;5738.053221218453;5745.080787074048;5837.328707198726;6375.234971803413;6495.610263384212;6500.122483464861;6511.381418765399;6512.023196520559;5696.316442026983;5802.883942321215;5882.441168089024;5883;5884.617499862496;5671.120976248688;5754.625949313281;5767.9134812977;5779.8555036124435;5909.054551271776;5369.27514785499;5404.945950540601;5448.645838020516;5472.644278121909;5484.341878974548;4010.218007488512;4050.8987275318354;4116.238495878272;4134.524529679005;4251.319788833772;4038.4250142445057;4041;4061.3501839705505;4109.301418758878;4110.23960567296 17:42:31 INFO - PROCESS | 5660 | |4;prototype.html;278.774192903748;285.60301181357914;290.76302813207246;291.7024634872429;293.0242293163764;4907.11671899058;4926.655134140611;4955.529224723655;4975.850724478267;4987.401511818583;4748.358971538842;4832;4846.757662116897;4860.590428775651;4872.561469467747;3584.677379035893;3709.1283548366246;3727.2731817295503;3791.4881490998637;3820.4460353248764;3775.5658099318516;3795.905102372449;3820.9808950955207;3825.8139976607204;3826.4642949987024;3768.057985503624;3769.3403654360513;3780.7164462665273;3788.7916164611074;3802.790846503441;3513.929721405583;3693.8707145250055;3795.4496597993275;3828.502294701671;3836.5804652278835;3264.689854463822;3269.2317305433203;3276.1645780326103;3280.491523813813;3298.224917144469;4723.8350305295535;4765.618750499952;4810.278458231258;4821.5178482151505;4827.468978412372;4269.124829409994;4284.228838809013;4289.24938135825;4294.184105020036;4294.892627684301;4982.676126051795;5032.295478632995;5057.8229761958155;5061.822836200715;5070.771815268322;3496.4230901901155;3508.6491350864962;3519.788812671248;3578.58846232684;3584.5482579555323;5277.3139491866195;5327.191058393229;5339.466053394668;5348;5356.705381204032;3364.9327013459592;3551;3573.9642603574152;3605.3955989584383;3624.257027309395;3603.2973570153567;3618.8552457901915;3628.800415977094;3639.1266096136737;3667.651573100551;4194.182134483746;4207.171473958683;4217.283061879488;4223.387608796707;4226.5139508956245;4943.678660887031;5084.923726144111;5085.771140298695;5087.389513258433;5115.746642072641;1206.6862615719976;1210.479493817667;1215.9542793197843;1217.8599461062092;1225.804840280737;778.381186956371;817.4563914996579;836.2891542189091;840.9824112823552;846.6697987784769;4227.47810788116;4327.588879056485;4354.847580334736;4414.426124603781;4420.403245561808;5170.6122040847085;5244.396894357198;5275.618868753926;5304.07178743726;5316.6544174628525;4427.69006169565;4429.313456414261;4441.0673758511075;4449.755263460541;4513.323001549794;2625.2935591865057;2691.744284292989;2698.406350602864;2705.2425320910174;2725.373164172212;4686.156491831435;4727.196376615983;4743.83396581118;4773.307870358848;4807.903841923142;5087.567556757643;5283.365996080418;5283.656562323514;5301.840944771586;5336.825898302367;4719.669623126417;4727.361806156194;4729.5034021427255;4751.239801631722;4758.095961767253;5056.7724452399;5077.466865979167;5104.387473503203;5119;5144.897102057863;4709.740964246999;5007.874803129951;5016.996600679806;5039.924401134059;5078.593712503065;4673.485916549109;4687.812287644435;4696.506866779076;4745.477997420212;4755.500672429345;3649.671529562352;3658;3661.3043521730788;3668.706503479769;3686.705063594852;5007.7245751484015;5089.796408143633;5091.694498330112;5105.846824595268;5113.360829896263;4599.4710608280475;4784.641151913551;4800.495947925418;4862.225287770009;4876.707397556158;4847.491013443679;4880.170371036861;4895.583875370633;4905.583025442735;4915.508449155056;4868.756562171948;4870.490148054115;4873.1959226727195;4878.80484780619;4883.754642566123;4766.737829419415;4818.927716084331;4880.365552478155;4885.558760165831;4905.288733133747;4743.359646447823;4752.526716717828;4769.761511924459;4775.853795089223;4782.187028205144 17:42:31 INFO - PROCESS | 5660 | |5;yui.html;566.6713306282356;584.4535359438925;601.2454369765943;623.4980840423457;640.4364159539605;10808.51361688724;11056.668299950994;11145.72135696608;11164.497597608106;11585.36280504572;10855.565777368896;11022.944885275563;11026.503807328669;11036.503357348918;11049.889501105006;716.2586722741976;717.666285177395;739.020797443387;740.5963749756396;740.6629983357559;746.2127455534436;746.9626518674072;747.2490147401853;749.3705287558449;750.0362034785302;771.3944553525483;772.038811679457;772.818387678895;773.3349319585152;774.6591499740097;771.2364758888716;771.5679219636993;774.724972634715;777.4247057177704;777.5490215674895;569.7122952908754;572.0589630058572;572.1789232451446;572.567711377907;573.6414740787009;10638.840417393745;10639.521221545048;10830.620928267474;10832.40421776802;10846.620368287073;9032.819343613157;9151.954240228823;9221.861672074925;9395.718128456088;9611.759706007337;8100.241232879441;8102;8113;8182.795430114235;8288.751337459886;2453.3621258472926;2490.8256422050463;2496.9126080587275;2560.295918622375;2580.7032191298053;50251.74874125606;50268.49731502675;51197.744011280076;52801.73599132018;53561;6865.5537390069485;7166.605836679033;7191.604461754549;7195.496315257882;7300.744473943492;13822;13880.930595347161;14167.362468688934;14747.410103595736;14913.627159321104;6149.477294430024;6160.691965401712;6256.436920677161;6278.560500764994;6280.874382512324;3339.8497067632015;3422.709069729051;3497.9300413991577;3524.488949102417;3599.226166374242;2524.255344673326;2574.292069680815;2590.352411897026;2594.5070436616984;2599.8050146239107;452.60623257765957;453.65748859610784;454.83853232102126;463.1663006588128;469.04783289921517;503.90173916086746;512.7974450092192;529.2511096797988;533.8371796601996;534.3747815056315;6682.756449654407;6846.623435710984;6890.5521141126665;6912.377885990285;6946.2011868634745;463.48090139044484;469.85904228731243;486.5402194925761;509.19547115557333;531.7155321902763;3194.5847039884666;3222.2749881276527;3282.7373810095137;3302.5716501919233;3320.535125082442;43006.35490467645;63388.366116339166;70149.64925175342;71250.64374678093;74247.25752742404;37886.810565946995;38686.872222027494;38912.2217555653;39784;54107;54704;56947.71526142343;58575.121373179434;59297;59494.70252648709;6158.414950579688;6323.810285691437;6394.776182833764;6664.300248473841;6820.761273355409;31571.526427103152;32071.198220044687;32071.358572828878;35736.821315893256;38015.42976855294;31944.6805531951;42396;42980.57019429766;47082;48572;7801.45389822707;8003.879941800761;8802.91197088021;8949.776255593662;9070.18368346852;9090.227330676702;9324.254059675073;9329.440233586007;9694.903050969682;10357.326773759682;8370.623321950405;8469.153084691729;8727.30181585459;8979.46123232608;9218.032106628707;8432.915670843213;8505.404621676424;8820.558972051243;9522.66670666551;9802.117809397188;8434.662613495391;8628.654853805778;8686.82626347482;9016.413933094327;9259.583318750807;7648.923510764821;7783.221677832172;7870.488418252795;7894;8545.273651739672;7778.261065198797;8103;8190.335404223074;8222.671093156447;8307.833843322978 17:42:31 INFO - PROCESS | 5660 | __end_tp_report 17:42:31 INFO - PROCESS | 5660 | __start_cc_report 17:42:31 INFO - PROCESS | 5660 | _x_x_mozilla_cycle_collect,340 17:42:31 INFO - PROCESS | 5660 | __end_cc_report 17:42:31 INFO - PROCESS | 5660 | __startTimestamp1479433351735__endTimestamp 17:42:31 INFO - PROCESS | 5660 | 17:42:31 INFO - PROCESS | 5660 | ------- Summary: start ------- 17:42:31 INFO - PROCESS | 5660 | Number of tests: 6 17:42:31 INFO - PROCESS | 5660 | 17:42:31 INFO - PROCESS | 5660 | [#0] dojo.html Cycles:165 Average:4472.18 Median:4592.66 stddev:466.99 (10.2%) stddev-sans-first:443.29 17:42:31 INFO - PROCESS | 5660 | Values: 2545.7 2553.9 2563.6 2589.1 2598.6 4423.6 4570.8 4583.5 4585.5 4615.5 4477.2 4526.2 4564.1 4565.7 4641.5 4104.8 4147.2 4163.9 4246.9 4279.0 3876.8 4274.7 4340.1 4341.5 4343.1 4101.5 4264.6 4266.3 4268.4 4332.0 4126.5 4134.9 4149.2 4189.1 4210.8 4095.6 4136.6 4141.6 4161.9 4241.1 4537.5 4564.2 4564.7 4569.1 4601.8 4812.8 4860.9 4869.2 4881.9 4910.1 4890.5 4913.2 4916.6 4918.4 4949.4 4474.3 4590.5 4592.7 4596.9 4651.6 4896.0 4925.0 4944.0 4986.7 4989.6 4766.9 4781.7 4784.6 4802.2 4808.4 4689.6 4834.1 4835.9 4842.8 4878.8 4673.3 4709.1 4713.7 4800.5 4827.9 4758.2 4770.4 4783.0 4798.6 4811.4 4066.6 4068.8 4069.8 4076.1 4127.8 3505.3 3512.6 3570.2 3608.8 3637.9 4181.9 4198.1 4202.0 4226.7 4237.2 4899.0 4900.5 4910.4 4912.9 4961.6 4004.9 4055.6 4060.1 4078.9 4191.0 4248.0 4264.1 4265.0 4279.5 4283.4 4415.6 4419.6 4421.3 4431.4 4431.6 4768.7 4770.1 4779.1 4784.2 4785.4 4445.1 4447.1 4450.3 4458.1 4458.4 4756.4 4768.7 4797.2 4810.8 4818.8 4774.7 4781.9 4846.6 4879.9 4921.3 4753.9 4758.2 4765.4 4772.1 4797.5 4620.6 4655.3 4668.4 4758.8 4787.9 4533.8 4580.7 4625.8 4646.3 4715.0 4760.3 4764.4 4771.6 4774.5 4804.8 4438.8 4660.1 4680.0 4682.6 4684.8 17:42:31 INFO - PROCESS | 5660 | 17:42:31 INFO - PROCESS | 5660 | [#1] ext.html Cycles:180 Average:41516.30 Median:310162.00 stddev:74787.98 (24.1%) stddev-sans-first:74934.49 17:42:31 INFO - PROCESS | 5660 | Values: 538.6 540.4 542.0 549.6 560.1 26883.3 28336.3 28348.6 28458.7 29755.9 27417.9 27693.9 27696.2 27744.4 27811.4 5346.7 5469.9 5482.7 5494.4 5501.8 5483.0 5556.8 5558.1 5564.1 5570.7 5548.2 5609.4 5610.6 5616.0 5628.7 5557.6 5582.5 5617.7 5618.7 5623.8 5572.3 5621.3 5625.5 5631.5 5634.2 25414.4 25483.0 25746.5 25757.5 25869.0 3001.2 3090.8 3158.0 3285.7 3345.2 17519.3 17742.2 17828.5 18466.3 18616.2 2618.7 2669.2 2707.3 2708.4 2711.7 225049.0 226142.0 226337.0 226556.9 226986.9 50825.7 51049.0 51078.7 51116.2 51271.5 52896.0 52970.7 52977.7 53145.0 53230.7 13534.5 13788.1 13809.4 13813.7 13816.2 10255.2 10353.3 10410.8 10411.5 10412.3 16242.6 16548.8 16756.9 16837.2 16877.7 5758.4 5770.6 5850.7 5946.4 5978.4 792.9 856.6 882.9 945.1 970.3 25483.6 25954.2 26754.9 26883.0 27200.9 939.9 945.1 953.7 955.6 1014.1 14195.9 14435.9 14575.3 14744.0 14884.9 306607.0 307250.0 309478.0 310765.0 311366.0 43139.1 43337.8 43388.3 43458.0 43462.3 1140.9 1160.8 1174.6 1176.4 1179.8 24940.4 26008.3 26904.2 26941.0 26973.0 40249.8 40937.8 42212.0 42342.6 45672.8 305852.0 308198.0 308919.0 309105.0 309559.0 22782.9 22811.0 23105.5 23126.9 23148.9 36036.5 36048.3 36224.5 37545.6 37830.2 31609.7 31769.0 31811.4 31991.9 32700.3 32212.7 32306.0 32387.2 32562.0 32608.0 31939.2 32588.0 32863.3 33011.3 33012.8 27579.4 30172.2 30178.2 30252.8 30294.2 23277.0 23686.4 23700.4 23943.4 24000.0 17:42:31 INFO - PROCESS | 5660 | 17:42:31 INFO - PROCESS | 5660 | [#2] jquery.html Cycles:180 Average:23193.94 Median:3970.42 stddev:62990.94 (1586.5%) stddev-sans-first:63144.26 17:42:31 INFO - PROCESS | 5660 | Values: 334.1 337.7 345.9 350.1 375.3 11265.4 11999.3 12249.0 12281.1 12308.4 14085.3 14851.6 14961.0 15466.1 15863.9 3877.4 4129.4 4134.4 4142.3 4145.3 3932.1 4008.7 4048.6 4055.4 4142.6 4025.3 4025.7 4034.0 4035.7 4041.1 3918.4 4018.4 4020.3 4023.7 4033.6 3715.6 3745.6 3756.3 3757.5 3758.5 15858.4 16151.6 16200.9 16319.3 16481.5 1874.7 1930.5 1939.4 2029.6 2426.8 10083.0 10551.8 10910.9 11109.8 11163.2 1433.4 1439.3 1445.9 1455.1 1463.6 42473.4 45575.5 64072.7 64661.7 66475.7 9137.9 9260.6 9454.4 9482.9 9744.8 12889.4 12929.9 13003.5 13013.9 13121.9 6884.2 7016.3 7023.5 7173.5 7202.9 6768.5 6780.9 6925.8 7009.6 7042.8 5783.4 5814.8 5851.7 5867.4 5936.6 1696.4 1722.2 1739.9 1772.6 1775.1 852.8 901.5 905.3 927.2 934.9 15003.2 15709.0 16900.7 17062.6 17400.1 793.8 842.4 844.3 845.0 846.7 8914.5 9401.3 9470.8 9489.3 9590.0 377164.0 381617.0 381769.0 381793.0 384172.0 46720.8 83402.6 83738.0 84617.0 85699.0 910.8 929.4 943.3 944.5 952.7 14971.5 15046.5 15222.5 15621.9 15800.3 36995.0 37264.8 38379.2 38631.8 40207.8 50722.5 50975.5 51438.7 51880.7 52898.7 7037.3 7156.0 7249.3 7387.0 7449.3 7388.0 10087.9 11361.9 11440.7 11539.5 9719.2 9913.0 10093.9 10288.6 10480.0 9608.6 10041.3 10076.6 10210.7 10254.9 10193.4 10289.2 10373.7 10603.4 10851.6 6662.2 6789.3 6910.8 6941.0 6991.0 7625.7 9927.9 10202.8 10275.6 10466.6 17:42:31 INFO - PROCESS | 5660 | 17:42:31 INFO - PROCESS | 5660 | [#3] mootools.html Cycles:180 Average:4269.33 Median:5387.11 stddev:2314.93 (43.0%) stddev-sans-first:2310.76 17:42:31 INFO - PROCESS | 5660 | Values: 1313.1 1340.2 1363.6 1595.3 1622.2 5543.5 5808.7 5841.7 6098.0 6235.0 6098.2 6346.3 6372.1 6374.5 6380.4 1678.0 1714.9 1717.1 1723.7 1730.1 1720.6 1728.6 1734.1 1739.1 1807.9 1752.4 1766.8 1770.1 1772.2 1774.3 1712.7 1729.2 1739.6 1741.6 1742.6 1746.1 1752.4 1761.4 1763.3 1781.3 6285.8 6330.1 6332.2 6336.0 6345.3 4048.6 4178.4 4179.7 4185.9 4186.5 2268.8 2358.6 2437.4 2605.2 2704.3 789.2 793.5 795.5 799.8 801.6 8490.7 8509.3 8514.7 8538.9 8568.4 3673.8 3728.7 3805.8 3828.8 3831.7 6979.9 7003.8 7012.4 7017.5 7060.2 4008.2 4015.9 4025.1 4026.1 4072.6 3718.7 3776.1 3782.7 3783.9 3790.0 2880.2 2933.9 2981.9 2990.5 2998.0 885.3 902.9 904.5 921.4 927.2 698.3 709.4 729.7 730.9 734.9 4495.1 4507.4 4531.8 4584.7 4766.0 378.5 391.9 394.4 395.6 398.3 3054.5 3130.0 3168.9 3171.9 3239.8 7055.8 7227.7 7578.2 7583.1 7598.3 7355.8 7464.4 7677.4 7748.5 7952.0 6008.1 6008.5 6229.1 6240.3 6247.6 4237.2 4305.3 4358.6 4453.7 4495.8 7197.3 7255.2 7342.1 7375.1 7394.5 7346.4 7417.7 7422.0 7442.4 7523.9 5633.3 5656.5 5738.1 5745.1 5837.3 6375.2 6495.6 6500.1 6511.4 6512.0 5696.3 5802.9 5882.4 5883.0 5884.6 5671.1 5754.6 5767.9 5779.9 5909.1 5369.3 5404.9 5448.6 5472.6 5484.3 4010.2 4050.9 4116.2 4134.5 4251.3 4038.4 4041.0 4061.4 4109.3 4110.2 17:42:31 INFO - PROCESS | 5660 | 17:42:31 INFO - PROCESS | 5660 | [#4] prototype.html Cycles:180 Average:4140.73 Median:4736.43 stddev:1209.73 (25.5%) stddev-sans-first:1177.89 17:42:31 INFO - PROCESS | 5660 | Values: 278.8 285.6 290.8 291.7 293.0 4907.1 4926.7 4955.5 4975.9 4987.4 4748.4 4832.0 4846.8 4860.6 4872.6 3584.7 3709.1 3727.3 3791.5 3820.4 3775.6 3795.9 3821.0 3825.8 3826.5 3768.1 3769.3 3780.7 3788.8 3802.8 3513.9 3693.9 3795.4 3828.5 3836.6 3264.7 3269.2 3276.2 3280.5 3298.2 4723.8 4765.6 4810.3 4821.5 4827.5 4269.1 4284.2 4289.2 4294.2 4294.9 4982.7 5032.3 5057.8 5061.8 5070.8 3496.4 3508.6 3519.8 3578.6 3584.5 5277.3 5327.2 5339.5 5348.0 5356.7 3364.9 3551.0 3574.0 3605.4 3624.3 3603.3 3618.9 3628.8 3639.1 3667.7 4194.2 4207.2 4217.3 4223.4 4226.5 4943.7 5084.9 5085.8 5087.4 5115.7 1206.7 1210.5 1216.0 1217.9 1225.8 778.4 817.5 836.3 841.0 846.7 4227.5 4327.6 4354.8 4414.4 4420.4 5170.6 5244.4 5275.6 5304.1 5316.7 4427.7 4429.3 4441.1 4449.8 4513.3 2625.3 2691.7 2698.4 2705.2 2725.4 4686.2 4727.2 4743.8 4773.3 4807.9 5087.6 5283.4 5283.7 5301.8 5336.8 4719.7 4727.4 4729.5 4751.2 4758.1 5056.8 5077.5 5104.4 5119.0 5144.9 4709.7 5007.9 5017.0 5039.9 5078.6 4673.5 4687.8 4696.5 4745.5 4755.5 3649.7 3658.0 3661.3 3668.7 3686.7 5007.7 5089.8 5091.7 5105.8 5113.4 4599.5 4784.6 4800.5 4862.2 4876.7 4847.5 4880.2 4895.6 4905.6 4915.5 4868.8 4870.5 4873.2 4878.8 4883.8 4766.7 4818.9 4880.4 4885.6 4905.3 4743.4 4752.5 4769.8 4775.9 4782.2 17:42:31 INFO - PROCESS | 5660 | 17:42:31 INFO - PROCESS | 5660 | [#5] yui.html Cycles:180 Average:12827.28 Median:6153.95 stddev:17226.85 (279.9%) stddev-sans-first:17250.58 17:42:31 INFO - PROCESS | 5660 | Values: 566.7 584.5 601.2 623.5 640.4 10808.5 11056.7 11145.7 11164.5 11585.4 10855.6 11022.9 11026.5 11036.5 11049.9 716.3 717.7 739.0 740.6 740.7 746.2 747.0 747.2 749.4 750.0 771.4 772.0 772.8 773.3 774.7 771.2 771.6 774.7 777.4 777.5 569.7 572.1 572.2 572.6 573.6 10638.8 10639.5 10830.6 10832.4 10846.6 9032.8 9152.0 9221.9 9395.7 9611.8 8100.2 8102.0 8113.0 8182.8 8288.8 2453.4 2490.8 2496.9 2560.3 2580.7 50251.7 50268.5 51197.7 52801.7 53561.0 6865.6 7166.6 7191.6 7195.5 7300.7 13822.0 13880.9 14167.4 14747.4 14913.6 6149.5 6160.7 6256.4 6278.6 6280.9 3339.8 3422.7 3497.9 3524.5 3599.2 2524.3 2574.3 2590.4 2594.5 2599.8 452.6 453.7 454.8 463.2 469.0 503.9 512.8 529.3 533.8 534.4 6682.8 6846.6 6890.6 6912.4 6946.2 463.5 469.9 486.5 509.2 531.7 3194.6 3222.3 3282.7 3302.6 3320.5 43006.4 63388.4 70149.6 71250.6 74247.3 37886.8 38686.9 38912.2 39784.0 54107.0 54704.0 56947.7 58575.1 59297.0 59494.7 6158.4 6323.8 6394.8 6664.3 6820.8 31571.5 32071.2 32071.4 35736.8 38015.4 31944.7 42396.0 42980.6 47082.0 48572.0 7801.5 8003.9 8802.9 8949.8 9070.2 9090.2 9324.3 9329.4 9694.9 10357.3 8370.6 8469.2 8727.3 8979.5 9218.0 8432.9 8505.4 8820.6 9522.7 9802.1 8434.7 8628.7 8686.8 9016.4 9259.6 7648.9 7783.2 7870.5 7894.0 8545.3 7778.3 8103.0 8190.3 8222.7 8307.8 17:42:31 INFO - PROCESS | 5660 | -------- Summary: end -------- 17:42:31 INFO - PROCESS | 5660 | 17:42:32 INFO - TEST-INFO | 5660: exit 0 17:42:32 INFO - TEST-OK | dromaeo_css | took 1119730ms 17:42:32 INFO - TEST-START | kraken 17:42:32 INFO - operating with platform_type : linux_ 17:42:32 INFO - Initialising browser for kraken test... 17:42:32 INFO - TEST-INFO | started process 6017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOAFlp2/profile http://localhost:48362/getInfo.html) 17:42:37 INFO - PROCESS | 6017 | __metrics Screen width/height:1600/1200 17:42:37 INFO - PROCESS | 6017 | colorDepth:24 17:42:37 INFO - PROCESS | 6017 | Browser inner width/height: 1024/697 17:42:37 INFO - PROCESS | 6017 | __metrics 17:42:37 ERROR - PROCESS | 6017 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 17:42:38 INFO - TEST-INFO | 6017: exit 0 17:42:38 INFO - Browser initialized. 17:42:38 INFO - Running cycle 1/1 for kraken test... 17:42:38 INFO - TEST-INFO | started process 6142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOAFlp2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:42:51 INFO - PROCESS | 6142 | RSS: Main: 187260928 17:42:51 INFO - PROCESS | 6142 | 17:42:54 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48362/tests/kraken/driver.html?testName=audio-beat-detection) 17:42:55 INFO - PROCESS | 6142 | RSS: Main: 200085504 17:42:55 INFO - PROCESS | 6142 | 17:42:58 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48362/tests/kraken/driver.html?testName=audio-dft) 17:42:58 INFO - PROCESS | 6142 | RSS: Main: 197484544 17:42:58 INFO - PROCESS | 6142 | 17:43:01 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48362/tests/kraken/driver.html?testName=audio-fft) 17:43:02 INFO - PROCESS | 6142 | RSS: Main: 194248704 17:43:02 INFO - PROCESS | 6142 | 17:43:04 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48362/tests/kraken/driver.html?testName=audio-oscillator) 17:43:05 INFO - PROCESS | 6142 | RSS: Main: 194961408 17:43:05 INFO - PROCESS | 6142 | 17:43:07 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:43:07 INFO - PROCESS | 6142 | RSS: Main: 195059712 17:43:07 INFO - PROCESS | 6142 | 17:43:11 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48362/tests/kraken/driver.html?testName=imaging-darkroom) 17:43:11 INFO - PROCESS | 6142 | RSS: Main: 200105984 17:43:11 INFO - PROCESS | 6142 | 17:43:15 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48362/tests/kraken/driver.html?testName=imaging-desaturate) 17:43:15 INFO - PROCESS | 6142 | RSS: Main: 197103616 17:43:15 INFO - PROCESS | 6142 | 17:43:18 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48362/tests/kraken/driver.html?testName=json-parse-financial) 17:43:19 INFO - PROCESS | 6142 | RSS: Main: 198221824 17:43:19 INFO - PROCESS | 6142 | 17:43:21 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:43:21 INFO - PROCESS | 6142 | RSS: Main: 198295552 17:43:21 INFO - PROCESS | 6142 | 17:43:23 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:43:24 INFO - PROCESS | 6142 | RSS: Main: 197931008 17:43:24 INFO - PROCESS | 6142 | 17:43:26 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:43:27 INFO - PROCESS | 6142 | RSS: Main: 198295552 17:43:27 INFO - PROCESS | 6142 | 17:43:30 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:43:30 INFO - PROCESS | 6142 | RSS: Main: 198520832 17:43:30 INFO - PROCESS | 6142 | 17:43:33 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:43:34 INFO - PROCESS | 6142 | RSS: Main: 198508544 17:43:34 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48362/tests/kraken/driver.html?testName=ai-astar) 17:43:36 INFO - PROCESS | 6142 | RSS: Main: 200851456 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | __start_tp_report 17:43:36 INFO - PROCESS | 6142 | _x_x_mozilla_page_load 17:43:36 INFO - PROCESS | 6142 | _x_x_mozilla_page_load_details 17:43:36 INFO - PROCESS | 6142 | |i|pagename|runs| 17:43:36 INFO - PROCESS | 6142 | |0;ai-astar;112;117;117;117;118;117;119;116;117;115 17:43:36 INFO - PROCESS | 6142 | |1;audio-beat-detection;156;132;134;176;133;132;131;135;159;133 17:43:36 INFO - PROCESS | 6142 | |2;audio-dft;169;168;164;162;163;162;162;167;164;164 17:43:36 INFO - PROCESS | 6142 | |3;audio-fft;77;76;76;114;79;78;78;77;101;77 17:43:36 INFO - PROCESS | 6142 | |4;audio-oscillator;84;83;112;84;86;84;102;84;84;119 17:43:36 INFO - PROCESS | 6142 | |5;imaging-gaussian-blur;119;118;117;121;119;118;118;118;117;119 17:43:36 INFO - PROCESS | 6142 | |6;imaging-darkroom;149;149;147;147;147;149;148;149;148;149 17:43:36 INFO - PROCESS | 6142 | |7;imaging-desaturate;96;97;97;96;96;96;97;97;97;96 17:43:36 INFO - PROCESS | 6142 | |8;json-parse-financial;71;65;64;64;66;66;66;65;66;65 17:43:36 INFO - PROCESS | 6142 | |9;json-stringify-tinderbox;66;66;65;67;66;66;66;66;67;67 17:43:36 INFO - PROCESS | 6142 | |10;stanford-crypto-aes;86;85;86;85;87;85;86;83;83;86 17:43:36 INFO - PROCESS | 6142 | |11;stanford-crypto-ccm;146;144;146;149;157;149;144;147;193;143 17:43:36 INFO - PROCESS | 6142 | |12;stanford-crypto-pbkdf2;186;185;184;183;178;185;179;178;183;178 17:43:36 INFO - PROCESS | 6142 | |13;stanford-crypto-sha256-iterative;76;72;71;71;72;70;73;70;72;73 17:43:36 INFO - PROCESS | 6142 | __end_tp_report 17:43:36 INFO - PROCESS | 6142 | __start_cc_report 17:43:36 INFO - PROCESS | 6142 | _x_x_mozilla_cycle_collect,891 17:43:36 INFO - PROCESS | 6142 | __end_cc_report 17:43:36 INFO - PROCESS | 6142 | __startTimestamp1479433416698__endTimestamp 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | ------- Summary: start ------- 17:43:36 INFO - PROCESS | 6142 | Number of tests: 14 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | [#0] ai-astar Cycles:10 Average:116.50 Median:117.00 stddev:1.90 (1.6%) stddev-sans-first:1.12 17:43:36 INFO - PROCESS | 6142 | Values: 112.0 117.0 117.0 117.0 118.0 117.0 119.0 116.0 117.0 115.0 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:134.50 stddev:15.77 (11.7%) stddev-sans-first:15.90 17:43:36 INFO - PROCESS | 6142 | Values: 156.0 132.0 134.0 176.0 133.0 132.0 131.0 135.0 159.0 133.0 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.59 (1.6%) stddev-sans-first:2.18 17:43:36 INFO - PROCESS | 6142 | Values: 169.0 168.0 164.0 162.0 163.0 162.0 162.0 167.0 164.0 164.0 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | [#3] audio-fft Cycles:10 Average:83.30 Median:77.00 stddev:13.15 (17.1%) stddev-sans-first:13.75 17:43:36 INFO - PROCESS | 6142 | Values: 77.0 76.0 76.0 114.0 79.0 78.0 78.0 77.0 101.0 77.0 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:84.00 stddev:13.60 (16.2%) stddev-sans-first:14.10 17:43:36 INFO - PROCESS | 6142 | Values: 84.0 83.0 112.0 84.0 86.0 84.0 102.0 84.0 84.0 119.0 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.50 stddev:1.17 (1.0%) stddev-sans-first:1.22 17:43:36 INFO - PROCESS | 6142 | Values: 119.0 118.0 117.0 121.0 119.0 118.0 118.0 118.0 117.0 119.0 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:149.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 17:43:36 INFO - PROCESS | 6142 | Values: 149.0 149.0 147.0 147.0 147.0 149.0 148.0 149.0 148.0 149.0 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:43:36 INFO - PROCESS | 6142 | Values: 96.0 97.0 97.0 96.0 96.0 96.0 97.0 97.0 97.0 96.0 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:1.99 (3.0%) stddev-sans-first:0.83 17:43:36 INFO - PROCESS | 6142 | Values: 71.0 65.0 64.0 64.0 66.0 66.0 66.0 65.0 66.0 65.0 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 17:43:36 INFO - PROCESS | 6142 | Values: 66.0 66.0 65.0 67.0 66.0 66.0 66.0 66.0 67.0 67.0 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:86.00 stddev:1.32 (1.5%) stddev-sans-first:1.36 17:43:36 INFO - PROCESS | 6142 | Values: 86.0 85.0 86.0 85.0 87.0 85.0 86.0 83.0 83.0 86.0 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:148.00 stddev:15.02 (10.1%) stddev-sans-first:15.78 17:43:36 INFO - PROCESS | 6142 | Values: 146.0 144.0 146.0 149.0 157.0 149.0 144.0 147.0 193.0 143.0 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:183.50 stddev:3.28 (1.8%) stddev-sans-first:3.13 17:43:36 INFO - PROCESS | 6142 | Values: 186.0 185.0 184.0 183.0 178.0 185.0 179.0 178.0 183.0 178.0 17:43:36 INFO - PROCESS | 6142 | 17:43:36 INFO - PROCESS | 6142 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:1.76 (2.4%) stddev-sans-first:1.13 17:43:36 INFO - PROCESS | 6142 | Values: 76.0 72.0 71.0 71.0 72.0 70.0 73.0 70.0 72.0 73.0 17:43:36 INFO - PROCESS | 6142 | -------- Summary: end -------- 17:43:36 INFO - PROCESS | 6142 | 17:43:37 INFO - TEST-INFO | 6142: exit 0 17:43:38 INFO - TEST-OK | kraken | took 65209ms 17:43:38 INFO - SUITE-END | took 1184s 17:43:38 INFO - Completed test suite (00:19:45) 17:43:38 INFO - javascript benchmark 17:43:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 5711.695072880003, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2545.732698066703, 2553.9233822985316, 2563.602641590554, 2589.0808762889174, 2598.5712357461007, 4423.57975992281, 4570.794314255858, 4583.472900616426, 4585.51852055534, 4615.469221039577, 4477.21648711475, 4526.230540808062, 4564.1328147652, 4565.657575681829, 4641.489436162019, 4104.774237416948, 4147.1705658868195, 4163.875083747493, 4246.8725938221905, 4279.0, 3876.8449262029485, 4274.722143060691, 4340.066885619591, 4341.45731783527, 4343.087951530182, 4101.52832424269, 4264.637505812009, 4266.31738921771, 4268.445102136733, 4332.025294308771, 4126.484189476316, 4134.875953721393, 4149.232392007489, 4189.07840275142, 4210.768407737573, 4095.5699651536456, 4136.565660605654, 4141.565135660772, 4161.91676166478, 4241.088166044285, 4537.478190008158, 4564.178447879381, 4564.7032942858605, 4569.063342014879, 4601.792919318638, 4812.831550895737, 4860.902781944376, 4869.172240719086, 4881.8535443936735, 4910.116179087763, 4890.462049174588, 4913.164761990471, 4916.557509824133, 4918.409790825088, 4949.430815456232, 4474.306482495218, 4590.495045544987, 4592.6555508337005, 4596.908061838744, 4651.558101980374, 4896.020795840846, 4924.9507504925205, 4944.035912996931, 4986.675866068694, 4989.600831933437, 4766.880827979328, 4781.737004464788, 4784.569388755029, 4802.159622066124, 4808.374911261513, 4689.62483001359, 4834.129856625841, 4835.879103022453, 4842.83050093245, 4878.756062196947, 4673.252279635242, 4709.128811169944, 4713.6936099153445, 4800.4719480857075, 4827.927581086286, 4758.16732071893, 4770.356001939763, 4782.976085119552, 4798.616110711135, 4811.398575178103, 4066.573009833925, 4068.7558746475306, 4069.8168582413864, 4076.062505623723, 4127.7936103194725, 3505.298940211968, 3512.648735126467, 3570.1610121621397, 3608.8376023079027, 3637.8544858205373, 4181.916361672749, 4198.055437526532, 4201.978990105091, 4226.746395216235, 4237.152569486115, 4899.044686286211, 4900.509949005071, 4910.435299940553, 4912.94371710084, 4961.603071754251, 4004.899877503086, 4055.6147166019773, 4060.0864805418546, 4078.938815917764, 4190.979045104755, 4247.978760106242, 4264.0832221072615, 4265.040365917644, 4279.507856596531, 4283.378910058024, 4415.580519850609, 4419.580139886705, 4421.270490369053, 4431.446069241345, 4431.601155895856, 4768.666193366431, 4770.0936822003705, 4779.091972525209, 4784.186688262934, 4785.401824771903, 4445.133199026159, 4447.110577884371, 4450.265706158577, 4458.06380660065, 4458.4426946631675, 4756.429228492603, 4768.737719425326, 4797.184478638709, 4810.783514741915, 4818.831340903052, 4774.665773395829, 4781.856544303677, 4846.588040016638, 4879.853604391874, 4921.26181072842, 4753.928691069567, 4758.16732071893, 4765.428148622187, 4772.117158325721, 4797.472278049481, 4620.561046700558, 4655.2784318430695, 4668.416447944007, 4758.762061896822, 4787.8563643090765, 4533.795979181011, 4580.67935244543, 4625.838095666635, 4646.279826626878, 4714.976425117852, 4760.262159365304, 4764.404449443819, 4771.594414474808, 4774.546418090275, 4804.759762011955, 4438.755868427267, 4660.114578230261, 4680.040591678766, 4682.578567928903, 4684.812607495662], "value": 4442.938516462058, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.5879801951505, 540.4487422828715, 541.9729013549321, 549.6290004247135, 560.1373884218305, 26883.327916802064, 28336.291592710168, 28348.57477137842, 28458.715412845864, 29755.85122074392, 27417.862910685468, 27693.861530692368, 27696.169114926535, 27744.445111097815, 27811.443771124566, 5346.6791992480385, 5469.945300546983, 5482.725863706799, 5494.36814766301, 5501.752421141058, 5483.0, 5556.777728890839, 5558.082916318803, 5564.081926482146, 5570.749316280777, 5548.223248745179, 5609.411011843759, 5610.607257491977, 5616.045272303698, 5628.662280263197, 5557.6109672322955, 5582.49757521823, 5617.691026993513, 5618.690971996539, 5623.775048998035, 5572.275604171432, 5621.269234999424, 5625.493705566478, 5631.465010823965, 5634.211210430543, 25414.36464088394, 25483.0, 25746.485070298488, 25757.484850302888, 25869.0, 3001.2496875781053, 3090.8311654656154, 3157.952630710541, 3285.65500622436, 3345.2305969626877, 17519.299228030864, 17742.20160092786, 17828.46514604564, 18466.261349546003, 18616.162272697624, 2618.738126187385, 2669.2125822882294, 2707.2690373599216, 2708.417690196617, 2711.6745990481268, 225049.0, 226142.0, 226337.0, 226556.86721566287, 226986.86506567526, 50825.74587127041, 51049.0, 51078.744606276734, 51116.23325650118, 51271.48728512667, 52896.0, 52970.73514632479, 52977.7351113242, 53145.0, 53230.73384633129, 13534.458621655023, 13788.103773254707, 13809.447622095004, 13813.723725525433, 13816.171029738249, 10255.230857685703, 10353.327033742782, 10410.843837342445, 10411.53148108337, 10412.32319899204, 16242.593935151715, 16548.75176872348, 16756.916215418845, 16837.242324095445, 16877.746833797257, 5758.3665796762325, 5770.6249093808765, 5850.707464626752, 5946.375630558816, 5978.432048955342, 792.8810678398287, 856.5588721808274, 882.9028806831243, 945.0596656326861, 970.2868391732071, 25483.617745733827, 25954.22137335883, 26754.866225669135, 26883.0, 27200.863995679894, 939.9248060155171, 945.1257586732245, 953.7043516509904, 955.5890966884167, 1014.1177175856905, 14195.929020355039, 14435.85564144366, 14575.271236438135, 14744.0, 14884.925575372054, 306607.0, 307250.0, 309478.0, 310765.0, 311366.0, 43139.13721725548, 43337.78331108324, 43388.34917476241, 43458.0, 43462.34806477906, 1140.948657310423, 1160.8316794064813, 1174.5888938871326, 1176.3823992404057, 1179.7640471905654, 24940.37649058788, 26008.34979125537, 26904.192874213804, 26941.0, 26973.0, 40249.798751006056, 40937.795311023256, 42212.0, 42342.57657423386, 45672.77163614161, 305852.0, 308198.0, 308919.0, 309105.0, 309559.0, 22782.886085569466, 22811.0, 23105.537889241783, 23126.884365578066, 23148.884255578614, 36036.45945310875, 36048.27903441969, 36224.456633149995, 37545.62454375421, 37830.243395131394, 31609.683903160672, 31769.0, 31811.363772723955, 31991.88028418994, 32700.34599307953, 32212.677873220968, 32306.0, 32387.19032024218, 32562.0, 32608.0, 31939.201519961258, 32588.0, 32863.342733144724, 33011.33977320488, 33012.834935825165, 27579.44841103207, 30172.24569385783, 30178.24554386158, 30252.84873575618, 30294.242643933198, 23277.0, 23686.407839804142, 23700.407489812893, 23943.401414964766, 24000.0], "value": 15097.630944561111, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.144589849984, 337.7078826814805, 345.94810778383237, 350.1089726645688, 375.3075575563085, 11265.43672816359, 11999.280043197414, 12249.020078393707, 12281.078919081072, 12308.384580770971, 14085.295735213249, 14851.554453366389, 14961.0, 15466.072035677838, 15863.889527733063, 3877.3990031545154, 4129.380592911058, 4134.441850350209, 4142.2543942090415, 4145.316022856225, 3932.1152740633415, 4008.719389642726, 4048.6356227939477, 4055.3511438169753, 4142.64787493062, 4025.315696331616, 4025.657819085381, 4033.9596604033877, 4035.6771458283265, 4041.0907545802106, 3918.4122381642696, 4018.437418761361, 4020.3165461871554, 4023.6982226333143, 4033.5764744701823, 3715.6284371562897, 3745.6441638044344, 3756.3426400379826, 3757.5490941087246, 3758.530183727034, 15858.36566537337, 16151.596210094724, 16200.918995405065, 16319.347226110942, 16481.505554833373, 1874.7281644161656, 1930.4594713480249, 1939.398786376228, 2029.594081183769, 2426.842255253403, 10082.970606691424, 10551.78896422075, 10910.890891091147, 11109.83335249972, 11163.162762792823, 1433.3621538415305, 1439.287552661429, 1445.9349329280208, 1455.1341951538818, 1463.5536161470748, 42473.36289955653, 45575.544244557794, 64072.679636601984, 64661.67669161671, 66475.66762166159, 9137.862932056025, 9260.629574816932, 9454.432734035843, 9482.905170948341, 9744.75638109053, 12889.355532223351, 12929.935350323189, 13003.479860805463, 13013.869861301455, 13121.934390328179, 6884.173899132136, 7016.2632923543315, 7023.508354415244, 7173.5337203081635, 7202.92797072033, 6768.492363072789, 6780.932190678129, 6925.75759848413, 7009.579425234502, 7042.753503627348, 5783.351744752809, 5814.825555233349, 5851.736671849691, 5867.442592953663, 5936.5844390892225, 1696.3553849537097, 1722.2422134260885, 1739.8608111351061, 1772.6011647379494, 1775.112443778111, 852.8166444214523, 901.5086777706166, 905.2712566383992, 927.1933417926313, 934.9439033658002, 15003.17482538449, 15709.0, 16900.746488802677, 17062.59078634085, 17400.129993500275, 793.8409921514537, 842.4313588327855, 844.2654890245526, 844.9704260350982, 846.7205822078699, 8914.465132092095, 9401.294902882311, 9470.810583788285, 9489.288303377274, 9589.952050239845, 377164.0, 381617.0, 381769.0, 381793.0, 384172.0, 46720.766396167804, 83402.58298708468, 83738.0, 84617.0, 85699.0, 910.7859652981545, 929.4051806843626, 943.3302355327656, 944.5182956692137, 952.6760901293593, 14971.475998340005, 15046.473373431878, 15222.543323700307, 15621.921890390475, 15800.288986995383, 36995.0, 37264.813675931444, 38379.2324153521, 38631.80684096562, 40207.798961005006, 50722.49277507325, 50975.49024509856, 51438.74280628723, 51880.740596296775, 52898.73550632222, 7037.296270372922, 7155.964220178866, 7249.347558719741, 7387.039684840936, 7449.329560339379, 7388.0, 10087.949560252151, 11361.898048860656, 11440.656780296604, 11539.538418463168, 9719.173870220828, 9913.0, 10093.89906100959, 10288.588456461657, 10480.0, 9608.567614457226, 10041.297109202285, 10076.647317343857, 10210.744731381776, 10254.897451025692, 10193.388396696222, 10289.176865850864, 10373.740656483647, 10603.402166469265, 10851.620193293196, 6662.233843108104, 6789.321067893171, 6910.7581234656545, 6940.993555934462, 6991.0, 7625.6949722010495, 9927.900720992697, 10202.806396624761, 10275.588976440858, 10466.63366782159], "value": 7624.3334910495705, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.120209459662, 1340.1824886819038, 1363.5772910397777, 1595.2741502616311, 1622.1889055472263, 5543.501084902358, 5808.651480911149, 5841.7371218295175, 6097.9695101524485, 6235.0, 6098.237720284965, 6346.333634968331, 6372.107904893319, 6374.490040796737, 6380.393862583059, 1677.991610041948, 1714.8799584029123, 1717.081361471613, 1723.689735847547, 1730.0571188702188, 1720.587059105812, 1728.5592173995612, 1734.0722713348362, 1739.0522165419814, 1807.864410169236, 1752.447978886653, 1766.8321509456582, 1770.070712875744, 1772.2025088710068, 1774.3346245158066, 1712.7002774514472, 1729.161356741979, 1739.5564131146602, 1741.582020315128, 1742.5730695979503, 1746.1269365317341, 1752.3603884582035, 1761.3835157694832, 1763.312308199803, 1781.26967943144, 6285.811425657192, 6330.145430366933, 6332.208473940757, 6336.049592561153, 6345.333739957284, 4048.6153815387493, 4178.39413285075, 4179.665626749853, 4185.874423767292, 4186.518550366686, 2268.750437451879, 2358.5872472317446, 2437.427204606916, 2605.192390358995, 2704.283364908301, 789.2107892107892, 793.5000949401898, 795.5187111797395, 799.7680672604996, 801.5951944268165, 8490.745277641681, 8509.319254459628, 8514.70198543048, 8538.914610853873, 8568.400211985163, 3673.834677439468, 3728.7203459740626, 3805.7906815125434, 3828.770273783582, 3831.7317787755146, 6979.930200697928, 7003.789886303419, 7012.403945664676, 7017.508774385744, 7060.223375428699, 4008.1983603278877, 4015.9397609035886, 4025.0742329264435, 4026.053877338823, 4072.552019277877, 3718.721095917817, 3776.131489757371, 3782.735208535376, 3783.9243215135543, 3790.0, 2880.1935458071775, 2933.867975941088, 2981.8807247709847, 2990.4766665833827, 2997.970020299813, 885.3183049052323, 902.8600566912139, 904.5386852705168, 921.3550514639645, 927.2165020557618, 698.2528694297155, 709.3615745828693, 729.7154109897144, 730.8757511223105, 734.8897665350133, 4495.123450927038, 4507.391502147234, 4531.84138555149, 4584.739196720929, 4766.046790641885, 378.50226951558614, 391.9353306704419, 394.35522920025966, 395.6162522353313, 398.2870661515912, 3054.5418187271644, 3129.9530507042414, 3168.920776980548, 3171.888983885553, 3239.8218098004836, 7055.8236044098285, 7227.674754636054, 7578.204288549733, 7583.090029196532, 7598.278163574451, 7355.77932662021, 7464.402847772274, 7677.424193185533, 7748.457607967388, 7952.0, 6008.068749343859, 6008.4592386684535, 6229.0967809668255, 6240.31356550779, 6247.5939063960695, 4237.237297286518, 4305.332673435622, 4358.564143585616, 4453.732776033448, 4495.7976891039325, 7197.316254955771, 7255.165655949633, 7342.082239720035, 7375.11498620169, 7394.482386232912, 7346.449016323691, 7417.703291868264, 7421.962890185515, 7442.4418168636485, 7523.924760752322, 5633.267675202197, 5656.490915817596, 5738.053221218453, 5745.080787074048, 5837.328707198726, 6375.234971803413, 6495.610263384212, 6500.122483464861, 6511.381418765399, 6512.023196520559, 5696.316442026983, 5802.883942321215, 5882.441168089024, 5883.0, 5884.617499862496, 5671.120976248688, 5754.625949313281, 5767.9134812977, 5779.8555036124435, 5909.054551271776, 5369.27514785499, 5404.945950540601, 5448.645838020516, 5472.644278121909, 5484.341878974548, 4010.218007488512, 4050.8987275318354, 4116.238495878272, 4134.524529679005, 4251.319788833772, 4038.4250142445057, 4041.0, 4061.3501839705505, 4109.301418758878, 4110.23960567296], "value": 3415.1101529645016, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.774192903748, 285.60301181357914, 290.76302813207246, 291.7024634872429, 293.0242293163764, 4907.11671899058, 4926.655134140611, 4955.529224723655, 4975.850724478267, 4987.401511818583, 4748.358971538842, 4832.0, 4846.757662116897, 4860.590428775651, 4872.561469467747, 3584.677379035893, 3709.1283548366246, 3727.2731817295503, 3791.4881490998637, 3820.4460353248764, 3775.5658099318516, 3795.905102372449, 3820.9808950955207, 3825.8139976607204, 3826.4642949987024, 3768.057985503624, 3769.3403654360513, 3780.7164462665273, 3788.7916164611074, 3802.790846503441, 3513.929721405583, 3693.8707145250055, 3795.4496597993275, 3828.502294701671, 3836.5804652278835, 3264.689854463822, 3269.2317305433203, 3276.1645780326103, 3280.491523813813, 3298.224917144469, 4723.8350305295535, 4765.618750499952, 4810.278458231258, 4821.5178482151505, 4827.468978412372, 4269.124829409994, 4284.228838809013, 4289.24938135825, 4294.184105020036, 4294.892627684301, 4982.676126051795, 5032.295478632995, 5057.8229761958155, 5061.822836200715, 5070.771815268322, 3496.4230901901155, 3508.6491350864962, 3519.788812671248, 3578.58846232684, 3584.5482579555323, 5277.3139491866195, 5327.191058393229, 5339.466053394668, 5348.0, 5356.705381204032, 3364.9327013459592, 3551.0, 3573.9642603574152, 3605.3955989584383, 3624.257027309395, 3603.2973570153567, 3618.8552457901915, 3628.800415977094, 3639.1266096136737, 3667.651573100551, 4194.182134483746, 4207.171473958683, 4217.283061879488, 4223.387608796707, 4226.5139508956245, 4943.678660887031, 5084.923726144111, 5085.771140298695, 5087.389513258433, 5115.746642072641, 1206.6862615719976, 1210.479493817667, 1215.9542793197843, 1217.8599461062092, 1225.804840280737, 778.381186956371, 817.4563914996579, 836.2891542189091, 840.9824112823552, 846.6697987784769, 4227.47810788116, 4327.588879056485, 4354.847580334736, 4414.426124603781, 4420.403245561808, 5170.6122040847085, 5244.396894357198, 5275.618868753926, 5304.07178743726, 5316.6544174628525, 4427.69006169565, 4429.313456414261, 4441.0673758511075, 4449.755263460541, 4513.323001549794, 2625.2935591865057, 2691.744284292989, 2698.406350602864, 2705.2425320910174, 2725.373164172212, 4686.156491831435, 4727.196376615983, 4743.83396581118, 4773.307870358848, 4807.903841923142, 5087.567556757643, 5283.365996080418, 5283.656562323514, 5301.840944771586, 5336.825898302367, 4719.669623126417, 4727.361806156194, 4729.5034021427255, 4751.239801631722, 4758.095961767253, 5056.7724452399, 5077.466865979167, 5104.387473503203, 5119.0, 5144.897102057863, 4709.740964246999, 5007.874803129951, 5016.996600679806, 5039.924401134059, 5078.593712503065, 4673.485916549109, 4687.812287644435, 4696.506866779076, 4745.477997420212, 4755.500672429345, 3649.671529562352, 3658.0, 3661.3043521730788, 3668.706503479769, 3686.705063594852, 5007.7245751484015, 5089.796408143633, 5091.694498330112, 5105.846824595268, 5113.360829896263, 4599.4710608280475, 4784.641151913551, 4800.495947925418, 4862.225287770009, 4876.707397556158, 4847.491013443679, 4880.170371036861, 4895.583875370633, 4905.583025442735, 4915.508449155056, 4868.756562171948, 4870.490148054115, 4873.1959226727195, 4878.80484780619, 4883.754642566123, 4766.737829419415, 4818.927716084331, 4880.365552478155, 4885.558760165831, 4905.288733133747, 4743.359646447823, 4752.526716717828, 4769.761511924459, 4775.853795089223, 4782.187028205144], "value": 3750.1367188408553, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.6713306282356, 584.4535359438925, 601.2454369765943, 623.4980840423457, 640.4364159539605, 10808.51361688724, 11056.668299950994, 11145.72135696608, 11164.497597608106, 11585.36280504572, 10855.565777368896, 11022.944885275563, 11026.503807328669, 11036.503357348918, 11049.889501105006, 716.2586722741976, 717.666285177395, 739.020797443387, 740.5963749756396, 740.6629983357559, 746.2127455534436, 746.9626518674072, 747.2490147401853, 749.3705287558449, 750.0362034785302, 771.3944553525483, 772.038811679457, 772.818387678895, 773.3349319585152, 774.6591499740097, 771.2364758888716, 771.5679219636993, 774.724972634715, 777.4247057177704, 777.5490215674895, 569.7122952908754, 572.0589630058572, 572.1789232451446, 572.567711377907, 573.6414740787009, 10638.840417393745, 10639.521221545048, 10830.620928267474, 10832.40421776802, 10846.620368287073, 9032.819343613157, 9151.954240228823, 9221.861672074925, 9395.718128456088, 9611.759706007337, 8100.241232879441, 8102.0, 8113.0, 8182.795430114235, 8288.751337459886, 2453.3621258472926, 2490.8256422050463, 2496.9126080587275, 2560.295918622375, 2580.7032191298053, 50251.74874125606, 50268.49731502675, 51197.744011280076, 52801.73599132018, 53561.0, 6865.5537390069485, 7166.605836679033, 7191.604461754549, 7195.496315257882, 7300.744473943492, 13822.0, 13880.930595347161, 14167.362468688934, 14747.410103595736, 14913.627159321104, 6149.477294430024, 6160.691965401712, 6256.436920677161, 6278.560500764994, 6280.874382512324, 3339.8497067632015, 3422.709069729051, 3497.9300413991577, 3524.488949102417, 3599.226166374242, 2524.255344673326, 2574.292069680815, 2590.352411897026, 2594.5070436616984, 2599.8050146239107, 452.60623257765957, 453.65748859610784, 454.83853232102126, 463.1663006588128, 469.04783289921517, 503.90173916086746, 512.7974450092192, 529.2511096797988, 533.8371796601996, 534.3747815056315, 6682.756449654407, 6846.623435710984, 6890.5521141126665, 6912.377885990285, 6946.2011868634745, 463.48090139044484, 469.85904228731243, 486.5402194925761, 509.19547115557333, 531.7155321902763, 3194.5847039884666, 3222.2749881276527, 3282.7373810095137, 3302.5716501919233, 3320.535125082442, 43006.35490467645, 63388.366116339166, 70149.64925175342, 71250.64374678093, 74247.25752742404, 37886.810565946995, 38686.872222027494, 38912.2217555653, 39784.0, 54107.0, 54704.0, 56947.71526142343, 58575.121373179434, 59297.0, 59494.70252648709, 6158.414950579688, 6323.810285691437, 6394.776182833764, 6664.300248473841, 6820.761273355409, 31571.526427103152, 32071.198220044687, 32071.358572828878, 35736.821315893256, 38015.42976855294, 31944.6805531951, 42396.0, 42980.57019429766, 47082.0, 48572.0, 7801.45389822707, 8003.879941800761, 8802.91197088021, 8949.776255593662, 9070.18368346852, 9090.227330676702, 9324.254059675073, 9329.440233586007, 9694.903050969682, 10357.326773759682, 8370.623321950405, 8469.153084691729, 8727.30181585459, 8979.46123232608, 9218.032106628707, 8432.915670843213, 8505.404621676424, 8820.558972051243, 9522.66670666551, 9802.117809397188, 8434.662613495391, 8628.654853805778, 8686.82626347482, 9016.413933094327, 9259.583318750807, 7648.923510764821, 7783.221677832172, 7870.488418252795, 7894.0, 8545.273651739672, 7778.261065198797, 8103.0, 8190.335404223074, 8222.671093156447, 8307.833843322978], "value": 5300.356946099099, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1584.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 116.0, 117.0, 115.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 134.0, 176.0, 133.0, 132.0, 131.0, 135.0, 159.0, 133.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 164.0, 162.0, 163.0, 162.0, 162.0, 167.0, 164.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 114.0, 79.0, 78.0, 78.0, 77.0, 101.0, 77.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 112.0, 84.0, 86.0, 84.0, 102.0, 84.0, 84.0, 119.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 121.0, 119.0, 118.0, 118.0, 118.0, 117.0, 119.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 147.0, 147.0, 147.0, 149.0, 148.0, 149.0, 148.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 65.0, 64.0, 64.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 85.0, 87.0, 85.0, 86.0, 83.0, 83.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 144.0, 146.0, 149.0, 157.0, 149.0, 144.0, 147.0, 193.0, 143.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 184.0, 183.0, 178.0, 185.0, 179.0, 178.0, 183.0, 178.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 71.0, 71.0, 72.0, 70.0, 73.0, 70.0, 72.0, 73.0], "value": 72.0, "unit": "score"}]}]} 17:43:38 INFO - Return code: 0 17:43:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:43:38 ERROR - # TBPL SUCCESS # 17:43:38 INFO - Running post-action listener: _resource_record_post_action 17:43:38 INFO - [mozharness: 2016-11-18 01:43:38.515096Z] Finished run-tests step (success) 17:43:38 INFO - Running post-run listener: _resource_record_post_run 17:43:38 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392695808; Read time: 16; Write time: 264896 17:43:38 INFO - TinderboxPrint: CPU usage
13.4% 17:43:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:43:38 INFO - TinderboxPrint: I/O write bytes / time
392,695,808 / 264,896 17:43:38 INFO - TinderboxPrint: CPU idle
8,295.1 (86.5%) 17:43:38 INFO - TinderboxPrint: CPU user
1,229.4 (12.8%) 17:43:38 INFO - TinderboxPrint: Swap in / out
0 / 0 17:43:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99897344; Read time: 0; Write time: 85572 17:43:38 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292798464; Read time: 0; Write time: 179324 17:43:39 INFO - Running post-run listener: _upload_blobber_files 17:43:39 INFO - Blob upload gear active. 17:43:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:43:39 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 17:43:39 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:43:39 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:43:39 INFO - (blobuploader) - INFO - Open directory for files ... 17:43:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:43:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:43:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:40 INFO - (blobuploader) - INFO - Done attempting. 17:43:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:43:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:43:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:43 INFO - (blobuploader) - INFO - Done attempting. 17:43:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:43:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:43:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:44 INFO - (blobuploader) - INFO - Done attempting. 17:43:44 INFO - (blobuploader) - INFO - Iteration through files over. 17:43:44 INFO - Return code: 0 17:43:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:43:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:43:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/aabaa355bb2dd29e098586815c990986ff489801ce88cd91885a3001e6ee42795955103df3ea86e7a2866da99b690e8903600fe479ef52a2f5b0b448d3966bc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4c026cb5cb53732eb9a5b09427b26af24988b67cddbb50a01193bb993697cd457d9380eb9c1fd9c021cb47e33ecdf0f433a686ce95d9c1152c121ba84f4d78dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/128fe0f19f8eae321ecadf0fa30be349980562a8af8c7f9e76f8f831ffe0830b54191030c758c89127222a5fe2d1f5cd327092a332c256e1b3aa2cec83302dfd"} 17:43:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:43:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:43:44 INFO - Contents: 17:43:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/aabaa355bb2dd29e098586815c990986ff489801ce88cd91885a3001e6ee42795955103df3ea86e7a2866da99b690e8903600fe479ef52a2f5b0b448d3966bc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4c026cb5cb53732eb9a5b09427b26af24988b67cddbb50a01193bb993697cd457d9380eb9c1fd9c021cb47e33ecdf0f433a686ce95d9c1152c121ba84f4d78dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/128fe0f19f8eae321ecadf0fa30be349980562a8af8c7f9e76f8f831ffe0830b54191030c758c89127222a5fe2d1f5cd327092a332c256e1b3aa2cec83302dfd"} 17:43:44 INFO - Running post-run listener: copy_logs_to_upload_dir 17:43:44 INFO - Copying logs to upload dir... 17:43:44 INFO - mkdir: /builds/slave/test/build/upload/logs 17:43:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.355203 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-17 17:43:44.332943) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 17:43:44.336611) ========= 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=20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/aabaa355bb2dd29e098586815c990986ff489801ce88cd91885a3001e6ee42795955103df3ea86e7a2866da99b690e8903600fe479ef52a2f5b0b448d3966bc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4c026cb5cb53732eb9a5b09427b26af24988b67cddbb50a01193bb993697cd457d9380eb9c1fd9c021cb47e33ecdf0f433a686ce95d9c1152c121ba84f4d78dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/128fe0f19f8eae321ecadf0fa30be349980562a8af8c7f9e76f8f831ffe0830b54191030c758c89127222a5fe2d1f5cd327092a332c256e1b3aa2cec83302dfd"} build_url:https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011779 build_url: 'https://queue.taskcluster.net/v1/task/Xe1sBzq0QXq7fZAdla9NtQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/aabaa355bb2dd29e098586815c990986ff489801ce88cd91885a3001e6ee42795955103df3ea86e7a2866da99b690e8903600fe479ef52a2f5b0b448d3966bc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4c026cb5cb53732eb9a5b09427b26af24988b67cddbb50a01193bb993697cd457d9380eb9c1fd9c021cb47e33ecdf0f433a686ce95d9c1152c121ba84f4d78dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/128fe0f19f8eae321ecadf0fa30be349980562a8af8c7f9e76f8f831ffe0830b54191030c758c89127222a5fe2d1f5cd327092a332c256e1b3aa2cec83302dfd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 17:43:44.362952) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 17:43:44.363373) ========= 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=20e666a3d4cfbb71505a330e000001b4-1479432176.136084-1033306928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 17:43:44.449508) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 17:43:44.449890) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 17:43:44.450303) ========= ========= Total master_lag: 0.19 =========