builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0259 starttime: 1484261996.12 results: success (0) buildid: 20170112124316 builduid: 9ed2943f86134e62ad4f68e08c61b769 revision: 91be97c8b0acd6d30ef826677996804941f2bbc0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 14:59:56.121422) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 14:59:56.121865) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 14:59:56.122143) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 14:59:56.437352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-01-12 14:59:56.437719) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vbPaJVbDZa/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-12 14:59:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to 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% 30.1M=0s 2017-01-12 14:59:56 (30.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093274 ========= master_lag: 4.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-01-12 15:00:00.763898) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2017-01-12 15:00:00.764264) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vbPaJVbDZa/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.024602 ========= master_lag: 3.63 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2017-01-12 15:00:04.417825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 15:00:04.418198) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 91be97c8b0acd6d30ef826677996804941f2bbc0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 91be97c8b0acd6d30ef826677996804941f2bbc0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vbPaJVbDZa/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-12 15:00:04,523 truncating revision to first 12 chars 2017-01-12 15:00:04,523 Setting DEBUG logging. 2017-01-12 15:00:04,523 attempt 1/10 2017-01-12 15:00:04,524 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/91be97c8b0ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 15:00:05,646 unpacking tar archive at: mozilla-beta-91be97c8b0ac/testing/mozharness/ program finished with exit code 0 elapsedTime=1.397484 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 15:00:05.843704) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 15:00:05.844028) ========= script_repo_revision: 91be97c8b0acd6d30ef826677996804941f2bbc0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 15:00:05.844406) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 15:00:05.844682) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 15:00:05.868589) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-01-12 15:00:05.868952) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vbPaJVbDZa/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:00:06 INFO - MultiFileLogger online at 20170112 15:00:06 in /builds/slave/test 15:00:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:00:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:00:06 INFO - {'append_to_log': False, 15:00:06 INFO - 'base_work_dir': '/builds/slave/test', 15:00:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:00:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:00:06 INFO - 'branch': 'Mozilla-Beta', 15:00:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:00:06 INFO - 'config_files': ('talos/mac_config.py',), 15:00:06 INFO - 'default_actions': ('clobber', 15:00:06 INFO - 'read-buildbot-config', 15:00:06 INFO - 'download-and-extract', 15:00:06 INFO - 'populate-webroot', 15:00:06 INFO - 'create-virtualenv', 15:00:06 INFO - 'install', 15:00:06 INFO - 'run-tests'), 15:00:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:00:06 INFO - 'download_minidump_stackwalk': True, 15:00:06 INFO - 'download_symbols': 'ondemand', 15:00:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:00:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:00:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:00:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:00:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:00:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:00:06 INFO - 'installer_path': 'installer.exe', 15:00:06 INFO - 'log_level': 'info', 15:00:06 INFO - 'log_name': 'talos', 15:00:06 INFO - 'log_to_console': True, 15:00:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:00:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:00:06 INFO - 'opt_config_files': (), 15:00:06 INFO - 'pip_index': False, 15:00:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:00:06 INFO - 'cmd': ('bash', 15:00:06 INFO - '-c', 15:00:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:00:06 INFO - 'enabled': True, 15:00:06 INFO - 'halt_on_failure': False, 15:00:06 INFO - 'name': 'check_screen_resolution'},), 15:00:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:00:06 INFO - 'cmd': ('bash', 15:00:06 INFO - '-c', 15:00:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:00:06 INFO - 'enabled': True, 15:00:06 INFO - 'halt_on_failure': False, 15:00:06 INFO - 'name': 'check_screen_resolution'},), 15:00:06 INFO - 'run_cmd_checks_enabled': True, 15:00:06 INFO - 'sps_profile': False, 15:00:06 INFO - 'sps_profile_interval': 0, 15:00:06 INFO - 'suite': 'dromaeojs-e10s', 15:00:06 INFO - 'system_bits': '32', 15:00:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:00:06 INFO - 'title': 't-yosemite-r7-0259', 15:00:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:00:06 INFO - 'use_talos_json': True, 15:00:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:00:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:00:06 INFO - 'work_dir': 'build'} 15:00:06 INFO - [mozharness: 2017-01-12 23:00:06.069463Z] Running clobber step. 15:00:06 INFO - Running pre-action listener: _resource_record_pre_action 15:00:06 INFO - Running main action method: clobber 15:00:06 INFO - rmtree: /builds/slave/test/build 15:00:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:00:08 INFO - Running post-action listener: _resource_record_post_action 15:00:08 INFO - [mozharness: 2017-01-12 23:00:08.501359Z] Finished clobber step (success) 15:00:08 INFO - [mozharness: 2017-01-12 23:00:08.501600Z] Running read-buildbot-config step. 15:00:08 INFO - Running pre-action listener: _resource_record_pre_action 15:00:08 INFO - Running main action method: read_buildbot_config 15:00:08 INFO - Using buildbot properties: 15:00:08 INFO - { 15:00:08 INFO - "project": "", 15:00:08 INFO - "product": "firefox", 15:00:08 INFO - "script_repo_revision": "production", 15:00:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 15:00:08 INFO - "repository": "", 15:00:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 15:00:08 INFO - "buildid": "20170112124316", 15:00:08 INFO - "pgo_build": "False", 15:00:08 INFO - "basedir": "/builds/slave/test", 15:00:08 INFO - "buildnumber": 34, 15:00:08 INFO - "slavename": "t-yosemite-r7-0259", 15:00:08 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 15:00:08 INFO - "platform": "yosemite_r7", 15:00:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:00:08 INFO - "branch": "mozilla-beta", 15:00:08 INFO - "repo_path": "releases/mozilla-beta", 15:00:08 INFO - "revision": "91be97c8b0acd6d30ef826677996804941f2bbc0", 15:00:08 INFO - "stage_platform": "macosx64", 15:00:08 INFO - "builduid": "9ed2943f86134e62ad4f68e08c61b769", 15:00:08 INFO - "slavebuilddir": "test" 15:00:08 INFO - } 15:00:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 15:00:08 INFO - Running post-action listener: _resource_record_post_action 15:00:08 INFO - [mozharness: 2017-01-12 23:00:08.507236Z] Finished read-buildbot-config step (success) 15:00:08 INFO - [mozharness: 2017-01-12 23:00:08.507432Z] Running download-and-extract step. 15:00:08 INFO - Running pre-action listener: _resource_record_pre_action 15:00:08 INFO - Running main action method: download_and_extract 15:00:08 INFO - mkdir: /builds/slave/test/build/tests 15:00:08 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')]} 15:00:08 INFO - trying https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 15:00:08 INFO - Downloading https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 15:00:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 15:00:09 INFO - Downloaded 1165 bytes. 15:00:09 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 15:00:09 INFO - Using the following test package requirements: 15:00:09 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 15:00:09 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:00:09 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 15:00:09 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:00:09 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 15:00:09 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:00:09 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:00:09 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 15:00:09 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 15:00:09 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:00:09 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 15:00:09 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:00:09 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 15:00:09 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:00:09 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 15:00:09 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:00:09 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 15:00:09 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 15:00:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 15:00:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 15:00:09 INFO - Fetch https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 15:00:10 INFO - Expected file size: 16236151 15:00:17 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:00:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 15:00:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 15:00:17 INFO - Fetch https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 15:00:17 INFO - Expected file size: 16236151 15:00:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 15:00:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 15:00:24 INFO - Fetch https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 15:00:24 INFO - Expected file size: 14414089 15:00: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')]} 15:00:25 INFO - trying https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:00:25 INFO - Downloading https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 15:00:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 15:00:28 INFO - Downloaded 86170609 bytes. 15:00:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:00:28 INFO - mkdir: /builds/slave/test/properties 15:00:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:00:28 INFO - Writing to file /builds/slave/test/properties/build_url 15:00:28 INFO - Contents: 15:00:28 INFO - build_url:https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:00:28 INFO - Running post-action listener: _resource_record_post_action 15:00:28 INFO - Running post-action listener: set_extra_try_arguments 15:00:28 INFO - [mozharness: 2017-01-12 23:00:28.900049Z] Finished download-and-extract step (success) 15:00:28 INFO - [mozharness: 2017-01-12 23:00:28.900162Z] Running populate-webroot step. 15:00:28 INFO - Running pre-action listener: _resource_record_pre_action 15:00:28 INFO - Running main action method: populate_webroot 15:00:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:00:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:00:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:00:28 INFO - '--tppagecycles', 15:00:28 INFO - '7'], 15:00:28 INFO - 'tests': ['tsvgm']}}, 15:00:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:00:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:00:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:00:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:00:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:00:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:00:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:28 INFO - 'talos_options': ['--disable-e10s'], 15:00:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:00:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:00:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:28 INFO - 'talos_options': ['--disable-e10s'], 15:00:28 INFO - 'tests': ['damp', 'tps']}, 15:00:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:28 INFO - 'tests': ['damp', 'tps']}, 15:00:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:00:28 INFO - 'tests': ['dromaeo_dom']}, 15:00:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:00:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:00:28 INFO - 'tests': ['basic_compositor_video']}, 15:00:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:00:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:00:28 INFO - 'tests': ['a11yr', 15:00:28 INFO - 'ts_paint', 15:00:28 INFO - 'tpaint', 15:00:28 INFO - 'sessionrestore', 15:00:28 INFO - 'sessionrestore_no_auto_restore', 15:00:28 INFO - 'tabpaint']}, 15:00:28 INFO - 'other-e10s': {'tests': ['a11yr', 15:00:28 INFO - 'ts_paint', 15:00:28 INFO - 'tpaint', 15:00:28 INFO - 'sessionrestore', 15:00:28 INFO - 'sessionrestore_no_auto_restore', 15:00:28 INFO - 'tabpaint']}, 15:00:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:00:28 INFO - 'ts_paint', 15:00:28 INFO - 'tpaint', 15:00:28 INFO - 'sessionrestore', 15:00:28 INFO - 'sessionrestore_no_auto_restore', 15:00:28 INFO - 'tabpaint']}, 15:00:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:00:28 INFO - 'ts_paint', 15:00:28 INFO - 'tpaint', 15:00:28 INFO - 'sessionrestore', 15:00:28 INFO - 'sessionrestore_no_auto_restore', 15:00:28 INFO - 'tabpaint']}, 15:00:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:00:28 INFO - 'tests': ['a11yr', 15:00:28 INFO - 'ts_paint', 15:00:28 INFO - 'tpaint', 15:00:28 INFO - 'sessionrestore', 15:00:28 INFO - 'sessionrestore_no_auto_restore', 15:00:28 INFO - 'tabpaint']}, 15:00:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:00:28 INFO - 'tests': ['a11yr', 15:00:28 INFO - 'ts_paint', 15:00:28 INFO - 'tpaint', 15:00:28 INFO - 'sessionrestore', 15:00:28 INFO - 'sessionrestore_no_auto_restore', 15:00:28 INFO - 'tabpaint']}, 15:00:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:00:28 INFO - 'tests': ['tsvgx', 15:00:28 INFO - 'tsvgr_opacity', 15:00:28 INFO - 'tart', 15:00:28 INFO - 'tscrollx', 15:00:28 INFO - 'cart']}, 15:00:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:00:28 INFO - 'tsvgr_opacity', 15:00:28 INFO - 'tart', 15:00:28 INFO - 'tscrollx', 15:00:28 INFO - 'cart']}, 15:00:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:28 INFO - 'talos_options': ['--disable-e10s'], 15:00:28 INFO - 'tests': ['tp5o']}, 15:00:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:28 INFO - 'tests': ['tp5o']}, 15:00:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:28 INFO - 'talos_options': ['--disable-e10s', 15:00:28 INFO - '--xperf_path', 15:00:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:00:28 INFO - 'tests': ['tp5n']}, 15:00:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:28 INFO - 'talos_options': ['--xperf_path', 15:00:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:00:28 INFO - 'tests': ['tp5n']}}, 15:00:28 INFO - 'talos.zip': {'path': '', 15:00:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:00:28 INFO - Running post-action listener: _resource_record_post_action 15:00:28 INFO - [mozharness: 2017-01-12 23:00:28.918417Z] Finished populate-webroot step (success) 15:00:28 INFO - [mozharness: 2017-01-12 23:00:28.918501Z] Running create-virtualenv step. 15:00:28 INFO - Running pre-action listener: _resource_record_pre_action 15:00:28 INFO - Running main action method: create_virtualenv 15:00:28 INFO - Creating virtualenv /builds/slave/test/build/venv 15:00:28 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 15:00:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:00:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:00:29 INFO - Using real prefix '/tools/python27' 15:00:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:00:29 INFO - Installing distribute.............................................................................................................................................................................................done. 15:00:32 INFO - Installing pip.................done. 15:00:32 INFO - Return code: 0 15:00:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:00: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')]} 15:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00: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')]} 15:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:32 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 0x108540490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdab9d73460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108354d30>, '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 0x1081badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:00:32 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 15:00:32 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 15:00:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 15:00:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:00:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:00:32 INFO - 'HOME': '/Users/cltbld', 15:00:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:00:32 INFO - 'LOGNAME': 'cltbld', 15:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:32 INFO - 'MOZ_NO_REMOTE': '1', 15:00:32 INFO - 'NO_EM_RESTART': '1', 15:00:32 INFO - 'PAGER': '/bin/cat', 15:00:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:32 INFO - 'PWD': '/builds/slave/test', 15:00:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:00:32 INFO - 'SHELL': '/bin/bash', 15:00:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 15:00:32 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 15:00:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:00:32 INFO - 'USER': 'cltbld', 15:00:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:00:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:32 INFO - 'XPC_FLAGS': '0x0', 15:00:32 INFO - 'XPC_SERVICE_NAME': '0', 15:00:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:32 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 15:00:32 INFO - Cleaning up... 15:00:32 INFO - Return code: 0 15:00:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:00: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')]} 15:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00: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')]} 15:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:32 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 0x108540490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdab9d73460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108354d30>, '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 0x1081badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:00:32 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 15:00:32 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 15:00:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 15:00:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:00:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:00:32 INFO - 'HOME': '/Users/cltbld', 15:00:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:00:32 INFO - 'LOGNAME': 'cltbld', 15:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:32 INFO - 'MOZ_NO_REMOTE': '1', 15:00:32 INFO - 'NO_EM_RESTART': '1', 15:00:32 INFO - 'PAGER': '/bin/cat', 15:00:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:32 INFO - 'PWD': '/builds/slave/test', 15:00:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:00:32 INFO - 'SHELL': '/bin/bash', 15:00:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 15:00:32 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 15:00:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:00:32 INFO - 'USER': 'cltbld', 15:00:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:00:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:32 INFO - 'XPC_FLAGS': '0x0', 15:00:32 INFO - 'XPC_SERVICE_NAME': '0', 15:00:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:33 INFO - Downloading/unpacking psutil>=3.1.1 15:00: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 15:00: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 15:00: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 15:00: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 15:00: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 15:00: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 15:00:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:00:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:00:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:00:36 INFO - Installing collected packages: psutil 15:00:36 INFO - Running setup.py install for psutil 15:00:36 INFO - building 'psutil._psutil_osx' extension 15:00:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:00:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:00:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:00:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:00:37 INFO - building 'psutil._psutil_posix' extension 15:00:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:00:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:00:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:00:37 INFO - ^ 15:00:37 INFO - 1 warning generated. 15:00:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:00:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:00:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:00:37 INFO - Successfully installed psutil 15:00:37 INFO - Cleaning up... 15:00:37 INFO - Return code: 0 15:00:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:00:37 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')]} 15:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:37 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')]} 15:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:37 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 0x108540490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdab9d73460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108354d30>, '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 0x1081badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:00:37 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 15:00:37 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 15:00:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 15:00:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:00:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:00:37 INFO - 'HOME': '/Users/cltbld', 15:00:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:00:37 INFO - 'LOGNAME': 'cltbld', 15:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:37 INFO - 'MOZ_NO_REMOTE': '1', 15:00:37 INFO - 'NO_EM_RESTART': '1', 15:00:37 INFO - 'PAGER': '/bin/cat', 15:00:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:37 INFO - 'PWD': '/builds/slave/test', 15:00:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:00:37 INFO - 'SHELL': '/bin/bash', 15:00:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 15:00:37 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 15:00:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:00:37 INFO - 'USER': 'cltbld', 15:00:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:00:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:37 INFO - 'XPC_FLAGS': '0x0', 15:00:37 INFO - 'XPC_SERVICE_NAME': '0', 15:00:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:00:37 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 15:00:37 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 15:00:37 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 15:00:37 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 15:00:37 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 15:00:37 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 15:00:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:00:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:00:40 INFO - Installing collected packages: mozsystemmonitor 15:00:40 INFO - Running setup.py install for mozsystemmonitor 15:00:40 INFO - Successfully installed mozsystemmonitor 15:00:40 INFO - Cleaning up... 15:00:40 INFO - Return code: 0 15:00:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:40 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 0x108540490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdab9d73460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108354d30>, '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 0x1081badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:00:40 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 15:00:40 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 15:00:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 15:00:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:00:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:00:40 INFO - 'HOME': '/Users/cltbld', 15:00:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:00:40 INFO - 'LOGNAME': 'cltbld', 15:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:40 INFO - 'MOZ_NO_REMOTE': '1', 15:00:40 INFO - 'NO_EM_RESTART': '1', 15:00:40 INFO - 'PAGER': '/bin/cat', 15:00:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:40 INFO - 'PWD': '/builds/slave/test', 15:00:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:00:40 INFO - 'SHELL': '/bin/bash', 15:00:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 15:00:40 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 15:00:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:00:40 INFO - 'USER': 'cltbld', 15:00:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:00:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:40 INFO - 'XPC_FLAGS': '0x0', 15:00:40 INFO - 'XPC_SERVICE_NAME': '0', 15:00:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:40 INFO - Downloading/unpacking jsonschema==2.5.1 15:00:40 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 15:00:40 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 15:00:40 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 15:00:40 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 15:00:40 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 15:00:40 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 15:00:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:00:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:00:43 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 15:00:43 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 15:00:43 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 15:00:43 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 15:00:43 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 15:00:43 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 15:00:43 INFO - Downloading functools32-3.2.3-2.tar.gz 15:00:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:00:43 INFO - warning: no files found matching '*.txt' 15:00:43 INFO - no previously-included directories found matching 'build' 15:00:43 INFO - no previously-included directories found matching 'dist' 15:00:43 INFO - no previously-included directories found matching '.git*' 15:00:44 INFO - Installing collected packages: jsonschema, functools32 15:00:44 INFO - Running setup.py install for functools32 15:00:44 INFO - warning: no files found matching '*.txt' 15:00:44 INFO - no previously-included directories found matching 'build' 15:00:44 INFO - no previously-included directories found matching 'dist' 15:00:44 INFO - no previously-included directories found matching '.git*' 15:00:44 INFO - Successfully installed jsonschema functools32 15:00:44 INFO - Cleaning up... 15:00:44 INFO - Return code: 0 15:00:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:00:44 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')]} 15:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:44 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')]} 15:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:44 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 0x108540490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdab9d73460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108354d30>, '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 0x1081badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:00:44 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 15:00:44 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 15:00:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 15:00:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:00:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:00:44 INFO - 'HOME': '/Users/cltbld', 15:00:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:00:44 INFO - 'LOGNAME': 'cltbld', 15:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:44 INFO - 'MOZ_NO_REMOTE': '1', 15:00:44 INFO - 'NO_EM_RESTART': '1', 15:00:44 INFO - 'PAGER': '/bin/cat', 15:00:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:44 INFO - 'PWD': '/builds/slave/test', 15:00:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:00:44 INFO - 'SHELL': '/bin/bash', 15:00:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 15:00:44 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 15:00:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:00:44 INFO - 'USER': 'cltbld', 15:00:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:00:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:44 INFO - 'XPC_FLAGS': '0x0', 15:00:44 INFO - 'XPC_SERVICE_NAME': '0', 15:00:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:00:44 INFO - Cleaning up... 15:00:44 INFO - Return code: 0 15:00:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:00:44 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')]} 15:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:44 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')]} 15:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:44 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 0x108540490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdab9d73460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108354d30>, '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 0x1081badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:00:44 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 15:00:44 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 15:00:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 15:00:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:00:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:00:44 INFO - 'HOME': '/Users/cltbld', 15:00:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:00:44 INFO - 'LOGNAME': 'cltbld', 15:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:44 INFO - 'MOZ_NO_REMOTE': '1', 15:00:44 INFO - 'NO_EM_RESTART': '1', 15:00:44 INFO - 'PAGER': '/bin/cat', 15:00:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:44 INFO - 'PWD': '/builds/slave/test', 15:00:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:00:44 INFO - 'SHELL': '/bin/bash', 15:00:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 15:00:44 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 15:00:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:00:44 INFO - 'USER': 'cltbld', 15:00:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:00:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:44 INFO - 'XPC_FLAGS': '0x0', 15:00:44 INFO - 'XPC_SERVICE_NAME': '0', 15:00:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:44 INFO - Downloading/unpacking blobuploader==1.2.4 15:00:44 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 15:00:44 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 15:00:44 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 15:00:44 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 15:00:44 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 15:00:44 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 15:00:47 INFO - Downloading blobuploader-1.2.4.tar.gz 15:00:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:00:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:00:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:00:48 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 15:00:48 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 15:00:48 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 15:00:48 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 15:00:48 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 15:00:48 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 15:00:48 INFO - Downloading docopt-0.6.1.tar.gz 15:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:00:48 INFO - Installing collected packages: blobuploader, requests, docopt 15:00:48 INFO - Running setup.py install for blobuploader 15:00:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:00:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:00:48 INFO - Running setup.py install for requests 15:00:49 INFO - Running setup.py install for docopt 15:00:49 INFO - Successfully installed blobuploader requests docopt 15:00:49 INFO - Cleaning up... 15:00:49 INFO - Return code: 0 15:00:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:50 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')]} 15:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:50 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 0x108540490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdab9d73460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108354d30>, '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 0x1081badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:00:50 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 15:00:50 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 15:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 15:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:00:50 INFO - 'HOME': '/Users/cltbld', 15:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:00:50 INFO - 'LOGNAME': 'cltbld', 15:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:50 INFO - 'MOZ_NO_REMOTE': '1', 15:00:50 INFO - 'NO_EM_RESTART': '1', 15:00:50 INFO - 'PAGER': '/bin/cat', 15:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:50 INFO - 'PWD': '/builds/slave/test', 15:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:00:50 INFO - 'SHELL': '/bin/bash', 15:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 15:00:50 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 15:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:00:50 INFO - 'USER': 'cltbld', 15:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:50 INFO - 'XPC_FLAGS': '0x0', 15:00:50 INFO - 'XPC_SERVICE_NAME': '0', 15:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:00:50 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-pa61QT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:00:50 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-xYrqww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:00:50 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-ysBX0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:00:50 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-Pd7cjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:00:50 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-Rjzl2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:00:50 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-X3jm2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:00:51 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-UKDywA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:00:51 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-UOsar5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:00:51 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-jWOkBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:00:51 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-xpUvML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:00:51 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-bYcGxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:00:51 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-huT5vC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:00:51 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-k22IEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:00:51 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-ZANfeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:00:51 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-mbQ_om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:00:51 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-0V8aRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:00:52 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-Kz_vLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:00:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:00:52 INFO - Running setup.py install for manifestparser 15:00:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:00:52 INFO - Running setup.py install for mozcrash 15:00:52 INFO - Running setup.py install for mozdebug 15:00:52 INFO - Running setup.py install for mozdevice 15:00:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:00:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:00:52 INFO - Running setup.py install for mozfile 15:00:52 INFO - Running setup.py install for mozhttpd 15:00:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:00:53 INFO - Running setup.py install for mozinfo 15:00:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:00:53 INFO - Running setup.py install for mozInstall 15:00:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:00:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:00:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:00:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:00:53 INFO - Running setup.py install for mozleak 15:00:53 INFO - Running setup.py install for mozlog 15:00:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:00:53 INFO - Running setup.py install for moznetwork 15:00:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:00:53 INFO - Running setup.py install for mozprocess 15:00:54 INFO - Running setup.py install for mozprofile 15:00:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:00:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:00:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:00:54 INFO - Running setup.py install for mozrunner 15:00:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:00:54 INFO - Running setup.py install for mozscreenshot 15:00:54 INFO - Running setup.py install for moztest 15:00:54 INFO - Running setup.py install for mozversion 15:00:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:00:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:00:54 INFO - Cleaning up... 15:00:54 INFO - Return code: 0 15:00:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:54 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 0x108540490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdab9d73460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108354d30>, '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 0x1081badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:00:54 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 15:00:54 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 15:00:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 15:00:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:00:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:00:54 INFO - 'HOME': '/Users/cltbld', 15:00:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:00:54 INFO - 'LOGNAME': 'cltbld', 15:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:54 INFO - 'MOZ_NO_REMOTE': '1', 15:00:54 INFO - 'NO_EM_RESTART': '1', 15:00:54 INFO - 'PAGER': '/bin/cat', 15:00:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:54 INFO - 'PWD': '/builds/slave/test', 15:00:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:00:54 INFO - 'SHELL': '/bin/bash', 15:00:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 15:00:54 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 15:00:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:00:54 INFO - 'USER': 'cltbld', 15:00:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:00:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:54 INFO - 'XPC_FLAGS': '0x0', 15:00:54 INFO - 'XPC_SERVICE_NAME': '0', 15:00:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:00:55 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-hBgBpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:00:55 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)) 15:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:00:55 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-WjCLjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:00:55 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-fs3sdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:00:55 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)) 15:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:00:55 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-u9bxnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:00:55 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)) 15:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:00:55 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-gUjWNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:00:55 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)) 15:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:00:55 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-fCYPST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:00:55 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)) 15:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:00:55 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-IfY3vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:00:55 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)) 15:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:00:55 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-OTxbN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:00:55 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)) 15:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:00:55 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-M3r0ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:00:56 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)) 15:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:00:56 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-emLMbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:00:56 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)) 15:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:00:56 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-JFjzng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:00:56 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)) 15:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:00:56 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-fmTEbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:00:56 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)) 15:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:00:56 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-CgpHbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:00:56 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)) 15:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:00:56 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-kLgEKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:00:56 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-WBNl2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:00:56 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)) 15:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:00:56 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-qB_OJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:00:56 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)) 15:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:00:56 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-S4lH8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:00:56 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)) 15:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:00:56 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)) 15:00:56 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)) 15:00:56 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)) 15:00:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:59 INFO - Downloading blessings-1.6.tar.gz 15:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:00:59 INFO - Installing collected packages: blessings 15:00:59 INFO - Running setup.py install for blessings 15:01:00 INFO - Successfully installed blessings 15:01:00 INFO - Cleaning up... 15:01:00 INFO - Return code: 0 15:01:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:01:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:00 INFO - Reading from file tmpfile_stdout 15:01:00 INFO - Current package versions: 15:01:00 INFO - blessings == 1.6 15:01:00 INFO - blobuploader == 1.2.4 15:01:00 INFO - docopt == 0.6.1 15:01:00 INFO - functools32 == 3.2.3-2 15:01:00 INFO - jsonschema == 2.5.1 15:01:00 INFO - manifestparser == 1.1 15:01:00 INFO - mozInstall == 1.12 15:01:00 INFO - mozcrash == 0.17 15:01:00 INFO - mozdebug == 0.1 15:01:00 INFO - mozdevice == 0.48 15:01:00 INFO - mozfile == 1.2 15:01:00 INFO - mozhttpd == 0.7 15:01:00 INFO - mozinfo == 0.9 15:01:00 INFO - mozleak == 0.1 15:01:00 INFO - mozlog == 3.4 15:01:00 INFO - moznetwork == 0.27 15:01:00 INFO - mozprocess == 0.23 15:01:00 INFO - mozprofile == 0.28 15:01:00 INFO - mozrunner == 6.12 15:01:00 INFO - mozscreenshot == 0.1 15:01:00 INFO - mozsystemmonitor == 0.3 15:01:00 INFO - moztest == 0.7 15:01:00 INFO - mozversion == 1.4 15:01:00 INFO - psutil == 3.1.1 15:01:00 INFO - requests == 1.2.3 15:01:00 INFO - wsgiref == 0.1.2 15:01:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:00 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')]} 15:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:00 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')]} 15:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:00 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 0x108540490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdab9d73460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108354d30>, '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 0x1081badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:01:00 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 15:01:00 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 15:01:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 15:01:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:00 INFO - 'HOME': '/Users/cltbld', 15:01:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:00 INFO - 'LOGNAME': 'cltbld', 15:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:00 INFO - 'MOZ_NO_REMOTE': '1', 15:01:00 INFO - 'NO_EM_RESTART': '1', 15:01:00 INFO - 'PAGER': '/bin/cat', 15:01:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:00 INFO - 'PWD': '/builds/slave/test', 15:01:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:00 INFO - 'SHELL': '/bin/bash', 15:01:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 15:01:00 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 15:01:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:00 INFO - 'USER': 'cltbld', 15:01:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:00 INFO - 'XPC_FLAGS': '0x0', 15:01:00 INFO - 'XPC_SERVICE_NAME': '0', 15:01:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:00 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)) 15:01:00 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)) 15:01:00 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)) 15:01:00 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)) 15:01:00 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)) 15:01:00 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)) 15:01:00 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)) 15:01:00 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)) 15:01:00 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)) 15:01:00 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)) 15:01:00 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)) 15:01:00 INFO - Cleaning up... 15:01:00 INFO - Return code: 0 15:01:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:01:00 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')]} 15:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:00 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')]} 15:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:00 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 0x108540490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdab9d73460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108354d30>, '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 0x1081badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:01:00 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 15:01:00 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 15:01:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 15:01:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:00 INFO - 'HOME': '/Users/cltbld', 15:01:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:00 INFO - 'LOGNAME': 'cltbld', 15:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:00 INFO - 'MOZ_NO_REMOTE': '1', 15:01:00 INFO - 'NO_EM_RESTART': '1', 15:01:00 INFO - 'PAGER': '/bin/cat', 15:01:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:00 INFO - 'PWD': '/builds/slave/test', 15:01:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:00 INFO - 'SHELL': '/bin/bash', 15:01:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 15:01:00 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 15:01:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:00 INFO - 'USER': 'cltbld', 15:01:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:00 INFO - 'XPC_FLAGS': '0x0', 15:01:00 INFO - 'XPC_SERVICE_NAME': '0', 15:01:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:01:01 INFO - Cleaning up... 15:01:01 INFO - Return code: 0 15:01:01 INFO - Running post-action listener: _resource_record_post_action 15:01:01 INFO - Running post-action listener: _start_resource_monitoring 15:01:01 INFO - Starting resource monitoring. 15:01:01 INFO - [mozharness: 2017-01-12 23:01:01.088699Z] Finished create-virtualenv step (success) 15:01:01 INFO - [mozharness: 2017-01-12 23:01:01.089687Z] Running install step. 15:01:01 INFO - Running pre-action listener: _resource_record_pre_action 15:01:01 INFO - Running main action method: install 15:01:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:01 INFO - Reading from file tmpfile_stdout 15:01:01 INFO - Detecting whether we're running mozinstall >=1.0... 15:01:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:01:01 INFO - Reading from file tmpfile_stdout 15:01:01 INFO - Output received: 15:01:01 INFO - Usage: mozinstall [options] installer 15:01:01 INFO - Options: 15:01:01 INFO - -h, --help show this help message and exit 15:01:01 INFO - -d DEST, --destination=DEST 15:01:01 INFO - Directory to install application into. [default: 15:01:01 INFO - "/builds/slave/test"] 15:01:01 INFO - --app=APP Application being installed. [default: firefox] 15:01:01 INFO - mkdir: /builds/slave/test/build/application 15:01:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:01:23 INFO - Reading from file tmpfile_stdout 15:01:23 INFO - Output received: 15:01:23 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:01:23 INFO - Running post-action listener: _resource_record_post_action 15:01:23 INFO - [mozharness: 2017-01-12 23:01:23.406101Z] Finished install step (success) 15:01:23 INFO - [mozharness: 2017-01-12 23:01:23.406241Z] Running run-tests step. 15:01:23 INFO - Running pre-action listener: _resource_record_pre_action 15:01:23 INFO - Running main action method: run_tests 15:01:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:01:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:01:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:01:23 INFO - 2017-01-12 15:01:23.420 screenresolution[1621:7343] starting screenresolution argv=screenresolution get 15:01:23 INFO - 2017-01-12 15:01:23.423 screenresolution[1621:7343] Display 0: 1600x1200x32@60 15:01:23 INFO - 2017-01-12 15:01:23.429 screenresolution[1622:7346] starting screenresolution argv=screenresolution list 15:01:23 INFO - Available Modes on Display 0 15:01:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:01:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:01:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:01:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:01:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:01:23 INFO - Intel Iris: 15:01:23 INFO - Chipset Model: Intel Iris 15:01:23 INFO - Type: GPU 15:01:23 INFO - Bus: Built-In 15:01:23 INFO - VRAM (Dynamic, Max): 1536 MB 15:01:23 INFO - Vendor: Intel (0x8086) 15:01:23 INFO - Device ID: 0x0a2e 15:01:23 INFO - Revision ID: 0x0009 15:01:23 INFO - Displays: 15:01:23 INFO - Display: 15:01:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:01:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:01:23 INFO - Display Serial Number: 1600x1200 60 15:01:23 INFO - Main Display: Yes 15:01:23 INFO - Mirror: Off 15:01:23 INFO - Online: Yes 15:01:23 INFO - Rotation: Supported 15:01:23 INFO - Return code: 0 15:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:01:23 INFO - Python 2.7.3 15:01:23 INFO - Return code: 0 15:01:23 INFO - grabbing minidump binary from tooltool 15:01:23 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')]} 15:01:23 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/macosx64/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 0x108354d30>, '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 0x1081badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:01:23 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:01:23 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:01:23 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:01:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:01:23 INFO - Return code: 0 15:01:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:01:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:01:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:01:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:01:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--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 15:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0259 --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 15:01:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbPaJVbDZa/Render', 15:01:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:23 INFO - 'HOME': '/Users/cltbld', 15:01:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:23 INFO - 'LOGNAME': 'cltbld', 15:01:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:01:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:23 INFO - 'MOZ_NO_REMOTE': '1', 15:01:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:01:23 INFO - 'NO_EM_RESTART': '1', 15:01:23 INFO - 'PAGER': '/bin/cat', 15:01:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:23 INFO - 'PWD': '/builds/slave/test', 15:01:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:01:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:23 INFO - 'SHELL': '/bin/bash', 15:01:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners', 15:01:23 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 15:01:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:23 INFO - 'USER': 'cltbld', 15:01:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:23 INFO - 'XPC_FLAGS': '0x0', 15:01:23 INFO - 'XPC_SERVICE_NAME': '0', 15:01:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--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 15:01:24 INFO - mozversion application_buildid: 20170112124316 15:01:24 INFO - mozversion application_changeset: 91be97c8b0acd6d30ef826677996804941f2bbc0 15:01:24 INFO - mozversion application_display_name: Firefox 15:01:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:01:24 INFO - mozversion application_name: Firefox 15:01:24 INFO - mozversion application_remotingname: firefox 15:01:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:01:24 INFO - mozversion application_vendor: Mozilla 15:01:24 INFO - mozversion application_version: 51.0 15:01:24 INFO - mozversion platform_buildid: 20170112124316 15:01:24 INFO - mozversion platform_changeset: 91be97c8b0acd6d30ef826677996804941f2bbc0 15:01:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:01:24 INFO - mozversion platform_version: 51.0 15:01:24 INFO - using testdate: 1484262084 15:01:24 INFO - actual date: 1484262084 15:01:24 INFO - starting webserver on 'localhost:49244' 15:01:24 INFO - SUITE-START | Running 2 tests 15:01:24 INFO - TEST-START | dromaeo_css 15:01:24 INFO - operating with platform_type : mac_ 15:01:24 INFO - Initialising browser for dromaeo_css test... 15:01:24 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpuPDQhe/profile http://localhost:49244/getInfo.html) 15:01:26 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 15:01:26 INFO - PROCESS | 1632 | colorDepth:24 15:01:26 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 15:01:26 INFO - PROCESS | 1632 | __metrics 15:01:26 ERROR - PROCESS | 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 15:01:27 INFO - TEST-INFO | 1632: exit 0 15:01:27 INFO - Browser initialized. 15:01:27 INFO - Running cycle 1/1 for dromaeo_css test... 15:01:27 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpuPDQhe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:01:39 INFO - PROCESS | 1636 | RSS: Main: 174931968 15:01:39 INFO - PROCESS | 1636 | 15:02:28 INFO - PROCESS | 1636 | 1484262148990 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] 15:04:40 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 15:04:41 INFO - PROCESS | 1636 | RSS: Main: 186126336 15:04:41 INFO - PROCESS | 1636 | 15:07:43 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 15:07:44 INFO - PROCESS | 1636 | RSS: Main: 196829184 15:07:44 INFO - PROCESS | 1636 | 15:10:46 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 15:10:47 INFO - PROCESS | 1636 | RSS: Main: 200577024 15:10:47 INFO - PROCESS | 1636 | 15:13:48 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 15:13:49 INFO - PROCESS | 1636 | RSS: Main: 204787712 15:13:49 INFO - PROCESS | 1636 | 15:16:52 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 15:16:52 INFO - PROCESS | 1636 | RSS: Main: 207360000 15:16:52 INFO - PROCESS | 1636 | 15:19:55 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 15:19:55 INFO - PROCESS | 1636 | RSS: Main: 207663104 15:19:55 INFO - PROCESS | 1636 | 15:19:55 INFO - PROCESS | 1636 | __start_tp_report 15:19:55 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 15:19:55 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 15:19:55 INFO - PROCESS | 1636 | |i|pagename|runs| 15:19:55 INFO - PROCESS | 1636 | |0;dojo.html;3462.913427164322;3598.748087633865;3602.765820221684;3626.528551288333;3679.8896033119;5931;6005.309389420218;6013.4587887090265;6048.304444988822;6054.9697251513735;5949.851253718659;5986.790462333819;6040.456358927696;6041.728122234499;6056.061310496869;5341.385740639818;5361.812336568221;5389.218563308318;5439.755211015514;5445.428230035848;5436.429174936614;5453.918191227135;5455.290812194409;5475.561955043587;5500.697461639608;5298.708571028611;5336.9859726652;5435.864103397427;5450.5367043801325;5461.098918678414;4892.584130348907;5355.143177091666;5420.620556561043;5441.782328706847;5500.477454641803;5242.659227150223;5396.973015134939;5398.433164517708;5404.027275090482;5428.240046393508;5780.421957804228;5940.108983652443;5993.430624090704;6104.328523862371;6115.266168059817;5154.510321519487;6200.162977997958;6232.532560057968;6239.625622462667;6261.780837670705;5624.3531993820825;6249.531285153632;6255.624662520263;6267.99712046075;6306.0225665022;6123.663198524079;6142.955697531431;6143.754249829957;6145.446909778052;6149.938500614981;6245.188125543741;6254.562180647402;6267.780627678009;6312.495000399957;6322.841928951813;6264.060390941395;6272.5922815016875;6291.96854015727;6294.370562943669;6297.622142671455;6230.470410015108;6292.811215663537;6295.370462953668;6297.149884765589;6316.431521163117;6225.782097626561;6237.376262373727;6253.812385628438;6303.243610766645;6305.464035556937;6243.687815609202;6268.1851359323;6287.339829317947;6297.874042519215;6309.558330916791;4985.5762260208285;5139.389341930614;5146.614003949719;5149.433562308143;5202.297689811827;4523.2988886722615;4525.389072475174;4554.362389265505;4590.196715574828;4609.562091601292;6111.633302001894;6116.724747386378;6159.199304090529;6162.969185154136;6171.444569988633;6303.495720342362;6334.1765570475545;6334.778282760081;6336.429721325103;6355.777547785898;5961.956657584992;5977;6053.7578496860515;6120.14317995481;6120.540959428061;5001.324821149171;5595.132754423071;5603.355614104348;5617.157426385993;5646.20953066571;6438.935610643927;6463.806085817433;6467;6497.64262965532;6503.414692677682;6191.7523299069335;6204.844878878064;6225.221847269091;6226.719797609027;6291.02489114188;6479.4816414685765;6499.382558657109;6505.804825855232;6510.056041873807;6513.706883190173;6259.405356491126;6268.028455589391;6280.7124539470215;6292.559520833498;6334.683265836782;6210;6210.689465526796;6255.155554000334;6271.090691849748;6289.056641503628;6121.452973575903;6289.40250676185;6297.716602752796;6311.463525600376;6319.494440444661;6265.4361107500545;6284.402981716729;6289.056641503811;6301.4643755279485;6306.873862522815;4762.714237145782;5163.27714120031;5967.433093856077;6124.197855633957;6150.7539698411565;6175.382461753788;6181.783637572664;6218.844528886814;6231.470325022424;6275.246970363585;4714.882127946692;5089.821856235014;6224.1597384354345;6227.875442491216;6250.687465626609 15:19:55 INFO - PROCESS | 1636 | |1;ext.html;475.6670330768463;496.42910652749345;514.8403994761624;530.607350560585;533.7918211897363;42671;45735.77132114339;45914.54085459145;45952.54047459525;45983.31025034627;45048;45451.77274113625;45459.31811022837;45507;45530.77234613831;9934.950325248381;10009.89990100097;10023.498825058754;10076.546555404988;10182.981701829833;10000.89999100007;10009.149222316075;10016.298859079867;10044.19646428284;10097.444640544767;10038.297319187623;10086.89913100867;10139.188864890792;10142.492875356204;10144.797104057914;10013.449260290718;10030.297879148462;10067.49662516875;10107.140893024029;10109.848352274721;9985.101340879355;9997.250206234561;10070.496475176213;10075.445850478221;10113.797724045478;42754;43500.78249608763;43511.78244108759;43791;44048.339274910584;3396.677315655009;3446.638102999174;3486.755927085105;3521.3309471200646;3680;32848.83575582131;32964.1758956028;32966.34067318664;33114.50328245078;33141.3371732564;3315.187778994162;3380.138064793462;3437.8968630941113;3449.223924616941;3464.9133771655656;539534;541860;545834;549048.2547587276;550084;66291.66854165698;66419.33580664132;66452.66773666101;66555.66722166455;66714.33285667178;36266.8186659065;36335.27329453396;36437.63562364395;38429;38589;17803;18224.271029158685;18404.723929141073;18409.631807364047;18512;13466.797998030037;13752.518661846987;13789.310534473438;13896.51362202318;13942.163470191821;19823.801761982482;20378.59242815165;20858.687119693215;20883.477913052295;20932.895335523226;7295.671694773748;7742.225777422325;8248.381371397169;8310.792230194173;8318.916810831935;916.7753900294471;958.5303201431249;990.8464188050864;1097.5170924793065;1104.4146602300793;26582.867085664835;26676.333091672863;26804.05155432901;27415.766290516975;31545.52681709776;1074.3070719385953;1089.4443833644739;1105.5080489182396;1121.1423261205184;1133.7109037195628;16481.91759041221;17021.31914723397;17068.146592670564;17107.828921710625;17200.483985480456;741098;746510;755345;756393;756552;63204.68397657982;63259.6837015812;63413.36586634075;63846;63972.04041939374;1416.4263473293333;1430.6709456824988;1444.6605047813755;1446.7540518111737;1453.2370505484494;26779.598306025036;31081.844590776902;31281.530777037908;32623.510647339834;32903.8354808234;55176.72411638077;55230.44769552414;55355;55507;55863.720681396335;615656;618465;619258;620033;620337;28324.433511329247;28649.427011459236;28995.13014609565;29025.564616530348;29089.7091029087;50175.74912125416;51297.743511282206;51714.22428663498;51909;51968.740156298976;40873.795631021654;42228.155436891706;42284.788576056926;43382.56617433785;44025.339619906365;41888.162236754484;41946.7902660497;42117.57882421259;43005;43291;35384.646153539165;35834.462483062256;39574.60425395824;41013.79493102516;41471.37792933048;33800.323993520484;37034.629653703116;37207.627923720414;37240.813795930844;37249;27376;27724;27743.583846242727;27744.44511109807;27873.860630696716 15:19:55 INFO - PROCESS | 1636 | |2;jquery.html;310.4102205808963;334.2618384401114;386.2988675553871;391.84522113765047;408.73023804289176;20796.376108716744;21273;21923.561528769435;21990.340289791293;22041.669374959387;21456.034478448506;21572.568548629017;22123.446913827163;22208.666869996963;22249.2212772553;6039.667818269993;6100.87798244036;6232.626042437446;6295.811125666238;6296.905546416808;4457.153140903218;4680.134175177603;5533.833984980457;6146;6257.5619706620555;5821.796237131702;6953.756618518353;6962.756303529378;6987.580745155282;6993.055937448456;5555.916661250064;6817.625030623314;6831.2144103428;6903.620300883449;6914.481413893953;6030.155778191057;6062.363451837582;6073.908891366633;6091.5431342649035;6097.085437184413;22406.2157824477;27022;27136.864315678493;27263.45473090547;27351.86324068387;2348.3072493614427;2387.5224955008894;2436.6223235398543;2463;2567.319660290006;16480.587985300343;16504;16561.92347497409;16581.25384357707;16747.748783768253;1868.598251375947;1903.8857668539931;1904.0955546115483;1931.7875033746277;1941.825235728791;124281.75718242883;126459.3677031609;131803.02295465575;132720.33639831835;133285.3335733315;11266.43667816606;11365.431728413712;11392.974632283134;11918.165728398928;11928.761424771455;13946.721065578835;14348;14476.493322733653;14484.710305794037;14489;9025.63897444108;9112.271018318519;9131.908680913239;9137.269018478506;9178.541072946326;9224.907750922404;9321.72034838956;9360.017198194091;9369.250459963187;9450.243980481546;6096.420840020191;6756.966215168991;7073.221945585981;7099;7108.466864985044;1489.9925500372428;1617.3530587764753;1711.4095637005214;1802.2430579156785;1940.427573865713;885.7165706973707;900.5902314447042;1014.3305418423953;1038.9272750907364;1046.9790604187874;17690.91154544219;22040.88979555092;22152.556948861256;22190.334289971328;22447;945.4138434170858;951.4196340232453;952.590386133969;969.486172328667;971.3928794503436;11147.38689372076;11404.771904561861;11739.530418783153;11764.99997500222;11773.470193841298;619503;620595;623517.8824105851;627196;671401;87753.56123219471;104526.47736761268;141827.87258191136;146916;147473;988.906053924876;1008.8083264179783;1023.3808545829814;1027.0961553832578;1039.3296323871061;19582.60834783268;19938.828218334496;20214.583747268498;20438.28466003683;20485.69271460959;56539.86920261654;57798;58380.708096459246;58709.82580348454;59147.81704365974;69262.65368673124;87735.8066048354;88587;88884;90360;8137.430379873352;8274.089850116363;8394.580270986304;8411.915880841358;8412.158784121539;11629.709257268636;12516.687082823002;13185.802212967004;13215.810577048112;13736.450541978209;11084.833727493933;11300.321980681185;11420.885791142315;11563.595274165364;11924.403779810802;9387.718368448957;11520.251183673034;11571.826422603499;11584.478698458759;11648.242864213798;9175.954120229357;11572.305661660328;11718.355490448108;11779.469923853618;12047.879521204675;8389.447952128876;8431.241188293083;8440.788980275542;8489.10864359258;8495.32037437016;10473.538718401322;10761.600991871006;11474.94262528682;11685.240459370114;11919 15:19:55 INFO - PROCESS | 1636 | |3;mootools.html;1307.392062690849;1516.9089854608724;1698.7197112476442;1868.7290342900271;1903.448000079977;8451.323894088473;8627.180417860292;8659.69691060813;9261.120193581615;9307.581158847852;8770;9040.72877813665;9090.227330676884;9143.679971201009;9153.496557689341;2321.698179236697;2435.427674496492;2457.336519139831;2459.5449841779237;2463.174836429789;2400.23192578375;2408.915687950922;2430.2101816909576;2442.9144979925704;2447.1801946347996;2396.544656515265;2419.0928401849305;2419.346776370379;2423.1397853761923;2428.9514209715794;2001.8898960557165;2330.9184178553837;2382.1543352110098;2393.700787401575;2394.461246219604;2380.642903564462;2389.8207634427313;2391.175044609607;2392.6650268962358;2397.05316400021;9036.638534458614;9184.494852783095;9204.631814727403;9207.17135457812;9230.707700921876;5447.972760136174;5481.917771233395;5483.698396588186;5590.552755779528;5592.0773072443;3627.782333060025;3706.6664000240107;3740.139767853409;3770.3967365221706;3785.3943369061094;1057.8307470804634;1130.248384824091;1131.6887855839627;1136.352279200856;1151.5739176504746;11928.940355298342;11956.163068585203;11991.820122698167;12013.459394327276;12078.758424831542;4349.934750978738;4452.332150177499;4497.168023915586;4733.668643194943;4764.166270902579;9047.68333108338;9069;9233.399829011092;9279.257659387233;9337.486438245825;5284.7886084556185;5292.894142117136;5360.973195134077;5382.650127741685;5400.972995135077;4606.723596584216;4701.459332176843;4904.4605093439695;5014.924776128361;5015;3875.8372488253412;3877.9612203878164;3940.822662980173;3981.402789581586;4001.2597669431248;1182.4501606752901;1190.5356910804794;1196.5931583261558;1200.9099317551218;1203.6148432501516;753.3408267765705;896.3814967672286;918.2424499787702;925.1997022575558;929.1266209762802;5369.7583608737705;6096.603720758225;6138.0179171332375;6200.689965501797;6282.120503129566;738.4941315199105;988.17981075707;990.6730778842965;1013.6097602423121;1025.9281850270559;3250.4636734938945;3631.745777795582;3920.980395098063;4034.9394759078637;4186;10830.296030757976;11183.664490065312;11196.496157672924;11199.440027998568;11206.607768728056;9345.579448924815;10902.291351062155;11005.449727513593;11044.171687123498;11152;7061.752838650623;8308.54303013328;8329.37529685276;8398.454100483448;8600.956995215109;5802.767889284381;5882.352941176553;5886.440788125121;6024.246969128859;6056.424639659225;10033.899661003588;10101.494925253855;10215.744606384602;10238.33450825694;10244.590216391261;10113.797724045626;10364.274500785174;10382;10394.272400932165;10544.314619549705;6664.166979127609;6804.387605115563;6998.825029374307;7123.109611298588;7182.209956904632;8457.196566326189;8614.61234244473;8662.480251184948;8675.002374726988;8717;6748.662566871539;7589.316961473494;7779.92220077792;7824.765257042298;7843.333316668147;7512.774616761506;7562.168161502121;7599.4680372373405;7627.5042122261875;7645.961770191114;7082.787516374517;7113.181984071898;7252.419806415369;7256.310650488195;7260.67326970277;4941.827036053721;5017.172166592617;5038.2190760432195;5095.184770436712;5152.27868098474;5023.34696489454;5077.213031980049;5125.000624878113;5173.508516690908;5199.376074871039 15:19:55 INFO - PROCESS | 1636 | |4;prototype.html;248.60595955410673;306.9232691827042;314.65388073119567;317.6315474050102;318.3410340594966;5277.736113194339;5385.542228910537;5580.274564306645;5731;5744.741486633101;4131.5455299916985;4644.953550464495;5271.630985830984;5516.420775818541;5626.578006649497;4023.436718859362;4247;4277.764722940237;4283.400323954634;4297.419848320484;3346.5482159908343;4210.62104410603;4281.4097471030045;4287.5498072702385;4289.335153051266;3632.600413954463;4179;4189.937150942723;4200.4539409876825;4228.619424251817;4208.537060923296;4211.336522073779;4236.724612900151;4241.724287921275;4253.468316460442;3028.9091327260217;3177.364527094567;3641.4537819327047;3660.9450858237146;3662.7985460799646;4346.456692913386;4531.342955271467;4916.827911023132;4981.907598808473;5381.973090134564;4012.578679238696;4156.8129434175535;4827.61379089672;4860.951390486085;4875.658703890729;4869.634777391674;5376.365580865387;5937.910931336033;5955.04719244923;5979.940200597982;3516.542849429558;3839.7696138231518;4006.238814625241;4013.3578627419765;4026.5973402659793;5894.675792831393;5969.850753731148;6190.876182476325;6269.9999999999545;6277.968610156966;3223.4520131577688;3486.6687664671817;3521.4013617685055;3986.7441755846817;4097.733647312974;3855.9807200963814;3895.6104389561383;3983.50206224222;4089.8159582818844;4156.334986402222;4804.543568361;4819.95180048202;4821.783019764119;4841.419029716386;4856.247281671346;4699.95300047002;5886;5977.073553599199;5984.820455386345;6024.066269728111;1159.5419809175328;1163.8603367595942;1205.9638210853689;1433.5412667946157;1457.672023794659;914.4284821986258;968.1867231525553;976.6679329028165;994.6170724271063;1004.7889943111882;4042.939355909664;4274.786260686953;4283.892902677458;4397.0985947881245;4631.907361852812;4194.7767683127995;4746.454157771831;4831.637627177975;5204.906969536364;5208.64575210448;4215.3044747616295;4235.53409124996;4453;4544.250198717241;4728.503507131771;2245.6182448983714;2356.5609594070056;2462.7537246275588;2764.350377661248;2776.0567602678207;4387.42963414754;5306.67505982623;5327.135502574068;5334.572769389918;5338.145896656516;4368.847090351823;4440.689151759346;4837.879053023703;4899.8195802868095;5295.808443100272;5579.939811435815;5720.599558030981;5773;5822.73797679097;5867.413258674183;5697.4587414195585;6264.310925798068;6293.307736149111;6293.937060629518;6294.244690637152;5471.276547887403;5670.432956704297;6152.753889844356;6153.200083989232;6169.383061693795;5054;5815.680137592473;6255.655938923403;6380;6490.578112422678;4122.587741225853;4123.958760412357;4126.587341265849;4136.338185890243;4150.294449943456;5314.52169304749;5332.440093790096;5729.4843464088435;5885.440883116097;6185.443310102112;5873.765049397976;5913.107805502198;6026.0659597762415;6056.878862422639;6086.113304875325;6056.304234814259;6078.300995385587;6085.208922840003;6093.928064458106;6102.908456373247;5601.103823388238;5857.765689372548;5925.9407405925385;5928.110783382527;5977.521798256216;5440.510354068153;6046.879062418639;6047.244094488189;6119.041906590027;6119.24633914749;4981.4769449207315;5337.786488540415;5623.565990672352;5961.552883533839;5972.343042265435 15:19:55 INFO - PROCESS | 1636 | |5;yui.html;641.5316818722332;721.9241979592143;749.6027105634013;772.4554189296547;827.2637352756044;15631.921840390796;15881.205939703026;16243.675126497463;16561.668766624676;16599.253033613502;14872.628184295398;15058.698826023472;15061;16052.277647505862;16639.16804159793;713.8893471511898;737.1485933746504;872.2324354568003;887.4010043220833;899.9740296062494;850.90640029597;870.5603670146598;870.9520976346298;871.2376670413388;872.2803686958284;905.8097799462121;924.6809850601531;927.174814415171;927.7077720518015;930.6137952749601;914.0174312613933;923.64901337492;925.2089463508738;925.8981512033671;925.9074092590687;659.6668682315448;671.2515545167153;676.2392308652766;683.3576438148125;683.5283654278531;15258.160801155933;15333.233338333039;15350.462733804263;15632.14023228722;15652.843471565253;14903.478378256817;14961.551153465414;14997.700045999129;15025.7746133807;15040.623984400368;11825.763484730258;11989.520419183222;12005.884165432557;12088.637340879788;12463.75072498554;3346.8159251241173;3927.253821773854;3970;4011.959880401188;4050.1697152083752;124588;125324;132939.33530332288;134335.6566434333;137463.31268343693;10929.617463388744;11571.6528504145;11631.76736465266;11658.70853228676;11741.706457338463;23687.407814804767;23759.7624023761;23824.285271441884;23872.92571834237;23902.043918243424;8088.757337279891;8117.512949223065;8413.747587572383;8423.115572864883;8473.830523389497;4587.79354929029;4708.270218116198;4721.008588196449;4732.361131247238;4737.6683632146105;3664.120611053328;3828.6554210120667;3830.482884810515;3833.4824798652385;3839.347310957144;676.2088356622763;696.0994598029813;706.33251577259;707.4517249131964;707.6108140522692;492.77578701690646;598.9940100598939;670.3966430212847;699.618707804248;734.372111844376;9930.354526955725;9993.350432221881;10163.542640581192;10221.182305415548;10245.538950747234;581.4737662415521;608.8492748704863;609.9695015249308;700.471144286071;711.1253158614933;4824.927626085611;5001.674891132065;5003.574696150795;5004;5006.199008158677;119363;120681;125443;180437;182440;151914;152949.23525382523;154763;157793.42206578018;161406.19296903675;127719;131658.3668326628;134139;134960.65039349676;136112;8390.328773697967;9527.28545359087;9603.567839447382;9620.807583848424;9635.903640963501;47571.81070473127;50460.49539504558;62034.68982655058;63423.0486542693;67742;90298;100466.4976675112;103091.93816123785;105226.47386763018;105697;11327.376994265394;11560.855279583771;11892.048636109264;12111.939440303095;12361.258324500559;13239.584780580706;13901.37443815051;14013.929930350283;14028.29858507091;14168.291585420893;13016.088873778745;13065.934670326587;13152.736945261233;13198.604041878374;13328.666783330495;12570.245785252913;12700.555480558505;13025.088243822842;13070.085094043327;13077.476900924237;11948.522059117538;12739.61781146567;13079;13929.512467063603;14322.498712545012;9362.485063321583;10563.841542377024;11300.49147788335;11403.885961140615;12278.75442491163;11450.828237576276;11739.471723772622;12046.457909394274;12130.272183669009;12168.878311216775 15:19:55 INFO - PROCESS | 1636 | __end_tp_report 15:19:55 INFO - PROCESS | 1636 | __start_cc_report 15:19:55 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,355 15:19:55 INFO - PROCESS | 1636 | __end_cc_report 15:19:55 INFO - PROCESS | 1636 | __startTimestamp1484263195587__endTimestamp 15:19:55 INFO - PROCESS | 1636 | 15:19:55 INFO - PROCESS | 1636 | ------- Summary: start ------- 15:19:55 INFO - PROCESS | 1636 | Number of tests: 6 15:19:55 INFO - PROCESS | 1636 | 15:19:55 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5872.89 Median:6159.20 stddev:631.12 (10.2%) stddev-sans-first:604.07 15:19:55 INFO - PROCESS | 1636 | Values: 3462.9 3598.7 3602.8 3626.5 3679.9 5931.0 6005.3 6013.5 6048.3 6055.0 5949.9 5986.8 6040.5 6041.7 6056.1 5341.4 5361.8 5389.2 5439.8 5445.4 5436.4 5453.9 5455.3 5475.6 5500.7 5298.7 5337.0 5435.9 5450.5 5461.1 4892.6 5355.1 5420.6 5441.8 5500.5 5242.7 5397.0 5398.4 5404.0 5428.2 5780.4 5940.1 5993.4 6104.3 6115.3 5154.5 6200.2 6232.5 6239.6 6261.8 5624.4 6249.5 6255.6 6268.0 6306.0 6123.7 6143.0 6143.8 6145.4 6149.9 6245.2 6254.6 6267.8 6312.5 6322.8 6264.1 6272.6 6292.0 6294.4 6297.6 6230.5 6292.8 6295.4 6297.1 6316.4 6225.8 6237.4 6253.8 6303.2 6305.5 6243.7 6268.2 6287.3 6297.9 6309.6 4985.6 5139.4 5146.6 5149.4 5202.3 4523.3 4525.4 4554.4 4590.2 4609.6 6111.6 6116.7 6159.2 6163.0 6171.4 6303.5 6334.2 6334.8 6336.4 6355.8 5962.0 5977.0 6053.8 6120.1 6120.5 5001.3 5595.1 5603.4 5617.2 5646.2 6438.9 6463.8 6467.0 6497.6 6503.4 6191.8 6204.8 6225.2 6226.7 6291.0 6479.5 6499.4 6505.8 6510.1 6513.7 6259.4 6268.0 6280.7 6292.6 6334.7 6210.0 6210.7 6255.2 6271.1 6289.1 6121.5 6289.4 6297.7 6311.5 6319.5 6265.4 6284.4 6289.1 6301.5 6306.9 4762.7 5163.3 5967.4 6124.2 6150.8 6175.4 6181.8 6218.8 6231.5 6275.2 4714.9 5089.8 6224.2 6227.9 6250.7 15:19:55 INFO - PROCESS | 1636 | 15:19:55 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:76964.94 Median:36050.64 stddev:172520.45 (478.6%) stddev-sans-first:172908.83 15:19:55 INFO - PROCESS | 1636 | Values: 475.7 496.4 514.8 530.6 533.8 42671.0 45735.8 45914.5 45952.5 45983.3 45048.0 45451.8 45459.3 45507.0 45530.8 9935.0 10009.9 10023.5 10076.5 10183.0 10000.9 10009.1 10016.3 10044.2 10097.4 10038.3 10086.9 10139.2 10142.5 10144.8 10013.4 10030.3 10067.5 10107.1 10109.8 9985.1 9997.3 10070.5 10075.4 10113.8 42754.0 43500.8 43511.8 43791.0 44048.3 3396.7 3446.6 3486.8 3521.3 3680.0 32848.8 32964.2 32966.3 33114.5 33141.3 3315.2 3380.1 3437.9 3449.2 3464.9 539534.0 541860.0 545834.0 549048.3 550084.0 66291.7 66419.3 66452.7 66555.7 66714.3 36266.8 36335.3 36437.6 38429.0 38589.0 17803.0 18224.3 18404.7 18409.6 18512.0 13466.8 13752.5 13789.3 13896.5 13942.2 19823.8 20378.6 20858.7 20883.5 20932.9 7295.7 7742.2 8248.4 8310.8 8318.9 916.8 958.5 990.8 1097.5 1104.4 26582.9 26676.3 26804.1 27415.8 31545.5 1074.3 1089.4 1105.5 1121.1 1133.7 16481.9 17021.3 17068.1 17107.8 17200.5 741098.0 746510.0 755345.0 756393.0 756552.0 63204.7 63259.7 63413.4 63846.0 63972.0 1416.4 1430.7 1444.7 1446.8 1453.2 26779.6 31081.8 31281.5 32623.5 32903.8 55176.7 55230.4 55355.0 55507.0 55863.7 615656.0 618465.0 619258.0 620033.0 620337.0 28324.4 28649.4 28995.1 29025.6 29089.7 50175.7 51297.7 51714.2 51909.0 51968.7 40873.8 42228.2 42284.8 43382.6 44025.3 41888.2 41946.8 42117.6 43005.0 43291.0 35384.6 35834.5 39574.6 41013.8 41471.4 33800.3 37034.6 37207.6 37240.8 37249.0 27376.0 27724.0 27743.6 27744.4 27873.9 15:19:55 INFO - PROCESS | 1636 | 15:19:55 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:37129.19 Median:2367.91 stddev:105590.94 (4459.2%) stddev-sans-first:105850.96 15:19:55 INFO - PROCESS | 1636 | Values: 310.4 334.3 386.3 391.8 408.7 20796.4 21273.0 21923.6 21990.3 22041.7 21456.0 21572.6 22123.4 22208.7 22249.2 6039.7 6100.9 6232.6 6295.8 6296.9 4457.2 4680.1 5533.8 6146.0 6257.6 5821.8 6953.8 6962.8 6987.6 6993.1 5555.9 6817.6 6831.2 6903.6 6914.5 6030.2 6062.4 6073.9 6091.5 6097.1 22406.2 27022.0 27136.9 27263.5 27351.9 2348.3 2387.5 2436.6 2463.0 2567.3 16480.6 16504.0 16561.9 16581.3 16747.7 1868.6 1903.9 1904.1 1931.8 1941.8 124281.8 126459.4 131803.0 132720.3 133285.3 11266.4 11365.4 11393.0 11918.2 11928.8 13946.7 14348.0 14476.5 14484.7 14489.0 9025.6 9112.3 9131.9 9137.3 9178.5 9224.9 9321.7 9360.0 9369.3 9450.2 6096.4 6757.0 7073.2 7099.0 7108.5 1490.0 1617.4 1711.4 1802.2 1940.4 885.7 900.6 1014.3 1038.9 1047.0 17690.9 22040.9 22152.6 22190.3 22447.0 945.4 951.4 952.6 969.5 971.4 11147.4 11404.8 11739.5 11765.0 11773.5 619503.0 620595.0 623517.9 627196.0 671401.0 87753.6 104526.5 141827.9 146916.0 147473.0 988.9 1008.8 1023.4 1027.1 1039.3 19582.6 19938.8 20214.6 20438.3 20485.7 56539.9 57798.0 58380.7 58709.8 59147.8 69262.7 87735.8 88587.0 88884.0 90360.0 8137.4 8274.1 8394.6 8411.9 8412.2 11629.7 12516.7 13185.8 13215.8 13736.5 11084.8 11300.3 11420.9 11563.6 11924.4 9387.7 11520.3 11571.8 11584.5 11648.2 9176.0 11572.3 11718.4 11779.5 12047.9 8389.4 8431.2 8440.8 8489.1 8495.3 10473.5 10761.6 11474.9 11685.2 11919.0 15:19:55 INFO - PROCESS | 1636 | 15:19:55 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5785.77 Median:5014.96 stddev:3255.44 (64.9%) stddev-sans-first:3247.17 15:19:55 INFO - PROCESS | 1636 | Values: 1307.4 1516.9 1698.7 1868.7 1903.4 8451.3 8627.2 8659.7 9261.1 9307.6 8770.0 9040.7 9090.2 9143.7 9153.5 2321.7 2435.4 2457.3 2459.5 2463.2 2400.2 2408.9 2430.2 2442.9 2447.2 2396.5 2419.1 2419.3 2423.1 2429.0 2001.9 2330.9 2382.2 2393.7 2394.5 2380.6 2389.8 2391.2 2392.7 2397.1 9036.6 9184.5 9204.6 9207.2 9230.7 5448.0 5481.9 5483.7 5590.6 5592.1 3627.8 3706.7 3740.1 3770.4 3785.4 1057.8 1130.2 1131.7 1136.4 1151.6 11928.9 11956.2 11991.8 12013.5 12078.8 4349.9 4452.3 4497.2 4733.7 4764.2 9047.7 9069.0 9233.4 9279.3 9337.5 5284.8 5292.9 5361.0 5382.7 5401.0 4606.7 4701.5 4904.5 5014.9 5015.0 3875.8 3878.0 3940.8 3981.4 4001.3 1182.5 1190.5 1196.6 1200.9 1203.6 753.3 896.4 918.2 925.2 929.1 5369.8 6096.6 6138.0 6200.7 6282.1 738.5 988.2 990.7 1013.6 1025.9 3250.5 3631.7 3921.0 4034.9 4186.0 10830.3 11183.7 11196.5 11199.4 11206.6 9345.6 10902.3 11005.4 11044.2 11152.0 7061.8 8308.5 8329.4 8398.5 8601.0 5802.8 5882.4 5886.4 6024.2 6056.4 10033.9 10101.5 10215.7 10238.3 10244.6 10113.8 10364.3 10382.0 10394.3 10544.3 6664.2 6804.4 6998.8 7123.1 7182.2 8457.2 8614.6 8662.5 8675.0 8717.0 6748.7 7589.3 7779.9 7824.8 7843.3 7512.8 7562.2 7599.5 7627.5 7646.0 7082.8 7113.2 7252.4 7256.3 7260.7 4941.8 5017.2 5038.2 5095.2 5152.3 5023.3 5077.2 5125.0 5173.5 5199.4 15:19:55 INFO - PROCESS | 1636 | 15:19:55 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4598.89 Median:4858.60 stddev:1470.55 (30.3%) stddev-sans-first:1437.97 15:19:55 INFO - PROCESS | 1636 | Values: 248.6 306.9 314.7 317.6 318.3 5277.7 5385.5 5580.3 5731.0 5744.7 4131.5 4645.0 5271.6 5516.4 5626.6 4023.4 4247.0 4277.8 4283.4 4297.4 3346.5 4210.6 4281.4 4287.5 4289.3 3632.6 4179.0 4189.9 4200.5 4228.6 4208.5 4211.3 4236.7 4241.7 4253.5 3028.9 3177.4 3641.5 3660.9 3662.8 4346.5 4531.3 4916.8 4981.9 5382.0 4012.6 4156.8 4827.6 4861.0 4875.7 4869.6 5376.4 5937.9 5955.0 5979.9 3516.5 3839.8 4006.2 4013.4 4026.6 5894.7 5969.9 6190.9 6270.0 6278.0 3223.5 3486.7 3521.4 3986.7 4097.7 3856.0 3895.6 3983.5 4089.8 4156.3 4804.5 4820.0 4821.8 4841.4 4856.2 4700.0 5886.0 5977.1 5984.8 6024.1 1159.5 1163.9 1206.0 1433.5 1457.7 914.4 968.2 976.7 994.6 1004.8 4042.9 4274.8 4283.9 4397.1 4631.9 4194.8 4746.5 4831.6 5204.9 5208.6 4215.3 4235.5 4453.0 4544.3 4728.5 2245.6 2356.6 2462.8 2764.4 2776.1 4387.4 5306.7 5327.1 5334.6 5338.1 4368.8 4440.7 4837.9 4899.8 5295.8 5579.9 5720.6 5773.0 5822.7 5867.4 5697.5 6264.3 6293.3 6293.9 6294.2 5471.3 5670.4 6152.8 6153.2 6169.4 5054.0 5815.7 6255.7 6380.0 6490.6 4122.6 4124.0 4126.6 4136.3 4150.3 5314.5 5332.4 5729.5 5885.4 6185.4 5873.8 5913.1 6026.1 6056.9 6086.1 6056.3 6078.3 6085.2 6093.9 6102.9 5601.1 5857.8 5925.9 5928.1 5977.5 5440.5 6046.9 6047.2 6119.0 6119.2 4981.5 5337.8 5623.6 5961.6 5972.3 15:19:55 INFO - PROCESS | 1636 | 15:19:55 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:27053.17 Median:103063.70 stddev:44781.03 (43.4%) stddev-sans-first:44862.74 15:19:55 INFO - PROCESS | 1636 | Values: 641.5 721.9 749.6 772.5 827.3 15631.9 15881.2 16243.7 16561.7 16599.3 14872.6 15058.7 15061.0 16052.3 16639.2 713.9 737.1 872.2 887.4 900.0 850.9 870.6 871.0 871.2 872.3 905.8 924.7 927.2 927.7 930.6 914.0 923.6 925.2 925.9 925.9 659.7 671.3 676.2 683.4 683.5 15258.2 15333.2 15350.5 15632.1 15652.8 14903.5 14961.6 14997.7 15025.8 15040.6 11825.8 11989.5 12005.9 12088.6 12463.8 3346.8 3927.3 3970.0 4012.0 4050.2 124588.0 125324.0 132939.3 134335.7 137463.3 10929.6 11571.7 11631.8 11658.7 11741.7 23687.4 23759.8 23824.3 23872.9 23902.0 8088.8 8117.5 8413.7 8423.1 8473.8 4587.8 4708.3 4721.0 4732.4 4737.7 3664.1 3828.7 3830.5 3833.5 3839.3 676.2 696.1 706.3 707.5 707.6 492.8 599.0 670.4 699.6 734.4 9930.4 9993.4 10163.5 10221.2 10245.5 581.5 608.8 610.0 700.5 711.1 4824.9 5001.7 5003.6 5004.0 5006.2 119363.0 120681.0 125443.0 180437.0 182440.0 151914.0 152949.2 154763.0 157793.4 161406.2 127719.0 131658.4 134139.0 134960.7 136112.0 8390.3 9527.3 9603.6 9620.8 9635.9 47571.8 50460.5 62034.7 63423.0 67742.0 90298.0 100466.5 103091.9 105226.5 105697.0 11327.4 11560.9 11892.0 12111.9 12361.3 13239.6 13901.4 14013.9 14028.3 14168.3 13016.1 13065.9 13152.7 13198.6 13328.7 12570.2 12700.6 13025.1 13070.1 13077.5 11948.5 12739.6 13079.0 13929.5 14322.5 9362.5 10563.8 11300.5 11403.9 12278.8 11450.8 11739.5 12046.5 12130.3 12168.9 15:19:55 INFO - PROCESS | 1636 | -------- Summary: end -------- 15:19:55 INFO - PROCESS | 1636 | 15:19:56 INFO - TEST-INFO | 1636: exit 0 15:19:56 INFO - TEST-OK | dromaeo_css | took 1112174ms 15:19:56 INFO - TEST-START | kraken 15:19:56 INFO - operating with platform_type : mac_ 15:19:56 INFO - Initialising browser for kraken test... 15:19:56 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmp1qmvOb/profile http://localhost:49244/getInfo.html) 15:19:58 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 15:19:58 INFO - PROCESS | 1647 | colorDepth:24 15:19:58 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 15:19:58 INFO - PROCESS | 1647 | __metrics 15:19:58 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 15:19:59 INFO - TEST-INFO | 1647: exit 0 15:19:59 INFO - Browser initialized. 15:19:59 INFO - Running cycle 1/1 for kraken test... 15:19:59 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmp1qmvOb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:20:11 INFO - PROCESS | 1650 | RSS: Main: 175357952 15:20:11 INFO - PROCESS | 1650 | 15:20:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 15:20:14 INFO - PROCESS | 1650 | RSS: Main: 187183104 15:20:14 INFO - PROCESS | 1650 | 15:20:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 15:20:18 INFO - PROCESS | 1650 | RSS: Main: 195710976 15:20:18 INFO - PROCESS | 1650 | 15:20:21 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 15:20:21 INFO - PROCESS | 1650 | RSS: Main: 198692864 15:20:21 INFO - PROCESS | 1650 | 15:20:23 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 15:20:24 INFO - PROCESS | 1650 | RSS: Main: 199839744 15:20:24 INFO - PROCESS | 1650 | 15:20:26 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:20:27 INFO - PROCESS | 1650 | RSS: Main: 200015872 15:20:27 INFO - PROCESS | 1650 | 15:20:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 15:20:30 INFO - PROCESS | 1650 | RSS: Main: 200470528 15:20:30 INFO - PROCESS | 1650 | 15:20:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 15:20:34 INFO - PROCESS | 1650 | RSS: Main: 200663040 15:20:34 INFO - PROCESS | 1650 | 15:20:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 15:20:37 INFO - PROCESS | 1650 | RSS: Main: 200962048 15:20:37 INFO - PROCESS | 1650 | 15:20:39 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:20:40 INFO - PROCESS | 1650 | RSS: Main: 200392704 15:20:40 INFO - PROCESS | 1650 | 15:20:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:20:42 INFO - PROCESS | 1650 | RSS: Main: 200445952 15:20:42 INFO - PROCESS | 1650 | 15:20:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:20:45 INFO - PROCESS | 1650 | RSS: Main: 200425472 15:20:45 INFO - PROCESS | 1650 | 15:20:48 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:20:49 INFO - PROCESS | 1650 | RSS: Main: 200581120 15:20:49 INFO - PROCESS | 1650 | 15:20:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:20:52 INFO - PROCESS | 1650 | RSS: Main: 200876032 15:20:52 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 15:20:54 INFO - PROCESS | 1650 | RSS: Main: 202342400 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | __start_tp_report 15:20:54 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 15:20:54 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 15:20:54 INFO - PROCESS | 1650 | |i|pagename|runs| 15:20:54 INFO - PROCESS | 1650 | |0;ai-astar;106;119;116;119;118;118;136;176;118;119 15:20:54 INFO - PROCESS | 1650 | |1;audio-beat-detection;146;110;114;140;111;111;109;109;133;113 15:20:54 INFO - PROCESS | 1650 | |2;audio-dft;197;195;195;197;201;195;199;194;199;195 15:20:54 INFO - PROCESS | 1650 | |3;audio-fft;81;58;59;85;62;63;73;82;106;83 15:20:54 INFO - PROCESS | 1650 | |4;audio-oscillator;87;70;90;72;70;72;89;70;70;85 15:20:54 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;105;118;90;109;136;87;91;87;108;87 15:20:54 INFO - PROCESS | 1650 | |6;imaging-darkroom;148;155;143;97;123;127;97;97;96;97 15:20:54 INFO - PROCESS | 1650 | |7;imaging-desaturate;92;93;92;115;134;126;76;74;139;152 15:20:54 INFO - PROCESS | 1650 | |8;json-parse-financial;57;58;58;57;62;61;60;62;62;60 15:20:54 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;67;67;76;105;99;69;69;66;65;69 15:20:54 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;83;81;83;83;83;86;85;102;101;89 15:20:54 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;135;152;154;137;141;137;151;138;169;142 15:20:54 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;165;162;162;160;165;161;161;169;159;165 15:20:54 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;66;66;65;66;67;66;67;64;66;66 15:20:54 INFO - PROCESS | 1650 | __end_tp_report 15:20:54 INFO - PROCESS | 1650 | __start_cc_report 15:20:54 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,910 15:20:54 INFO - PROCESS | 1650 | __end_cc_report 15:20:54 INFO - PROCESS | 1650 | __startTimestamp1484263254279__endTimestamp 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | ------- Summary: start ------- 15:20:54 INFO - PROCESS | 1650 | Number of tests: 14 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:124.50 Median:119.00 stddev:19.48 (16.4%) stddev-sans-first:19.48 15:20:54 INFO - PROCESS | 1650 | Values: 106.0 119.0 116.0 119.0 118.0 118.0 136.0 176.0 118.0 119.0 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:119.60 Median:113.50 stddev:14.27 (12.6%) stddev-sans-first:11.50 15:20:54 INFO - PROCESS | 1650 | Values: 146.0 110.0 114.0 140.0 111.0 111.0 109.0 109.0 133.0 113.0 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:196.70 Median:197.00 stddev:2.31 (1.2%) stddev-sans-first:2.45 15:20:54 INFO - PROCESS | 1650 | Values: 197.0 195.0 195.0 197.0 201.0 195.0 199.0 194.0 199.0 195.0 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:75.20 Median:77.00 stddev:15.17 (19.7%) stddev-sans-first:15.95 15:20:54 INFO - PROCESS | 1650 | Values: 81.0 58.0 59.0 85.0 62.0 63.0 73.0 82.0 106.0 83.0 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:78.50 stddev:8.95 (11.4%) stddev-sans-first:8.80 15:20:54 INFO - PROCESS | 1650 | Values: 87.0 70.0 90.0 72.0 70.0 72.0 89.0 70.0 70.0 85.0 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:101.80 Median:87.00 stddev:16.48 (18.9%) stddev-sans-first:17.44 15:20:54 INFO - PROCESS | 1650 | Values: 105.0 118.0 90.0 109.0 136.0 87.0 91.0 87.0 108.0 87.0 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:118.00 Median:96.50 stddev:24.15 (25.0%) stddev-sans-first:23.04 15:20:54 INFO - PROCESS | 1650 | Values: 148.0 155.0 143.0 97.0 123.0 127.0 97.0 97.0 96.0 97.0 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:109.30 Median:75.00 stddev:27.58 (36.8%) stddev-sans-first:28.53 15:20:54 INFO - PROCESS | 1650 | Values: 92.0 93.0 92.0 115.0 134.0 126.0 76.0 74.0 139.0 152.0 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:60.50 stddev:2.06 (3.4%) stddev-sans-first:1.94 15:20:54 INFO - PROCESS | 1650 | Values: 57.0 58.0 58.0 57.0 62.0 61.0 60.0 62.0 62.0 60.0 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:75.20 Median:69.00 stddev:14.51 (21.0%) stddev-sans-first:15.08 15:20:54 INFO - PROCESS | 1650 | Values: 67.0 67.0 76.0 105.0 99.0 69.0 69.0 66.0 65.0 69.0 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:83.00 stddev:7.65 (9.2%) stddev-sans-first:7.93 15:20:54 INFO - PROCESS | 1650 | Values: 83.0 81.0 83.0 83.0 83.0 86.0 85.0 102.0 101.0 89.0 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:146.50 stddev:10.75 (7.3%) stddev-sans-first:10.70 15:20:54 INFO - PROCESS | 1650 | Values: 135.0 152.0 154.0 137.0 141.0 137.0 151.0 138.0 169.0 142.0 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.50 stddev:3.03 (1.9%) stddev-sans-first:3.12 15:20:54 INFO - PROCESS | 1650 | Values: 165.0 162.0 162.0 160.0 165.0 161.0 161.0 169.0 159.0 165.0 15:20:54 INFO - PROCESS | 1650 | 15:20:54 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 15:20:54 INFO - PROCESS | 1650 | Values: 66.0 66.0 65.0 66.0 67.0 66.0 67.0 64.0 66.0 66.0 15:20:54 INFO - PROCESS | 1650 | -------- Summary: end -------- 15:20:54 INFO - PROCESS | 1650 | 15:20:55 INFO - TEST-INFO | 1650: exit 0 15:20:55 INFO - TEST-OK | kraken | took 58888ms 15:20:55 INFO - SUITE-END | took 1171s 15:20:55 INFO - Completed test suite (00:19:31) 15:20:55 INFO - javascript benchmark 15:20:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7609.739610695507, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3462.913427164322, 3598.748087633865, 3602.765820221684, 3626.528551288333, 3679.8896033119, 5931.0, 6005.309389420218, 6013.4587887090265, 6048.304444988822, 6054.9697251513735, 5949.851253718659, 5986.790462333819, 6040.456358927696, 6041.728122234499, 6056.061310496869, 5341.385740639818, 5361.812336568221, 5389.218563308318, 5439.755211015514, 5445.428230035848, 5436.429174936614, 5453.918191227135, 5455.290812194409, 5475.561955043587, 5500.697461639608, 5298.708571028611, 5336.9859726652, 5435.864103397427, 5450.5367043801325, 5461.098918678414, 4892.584130348907, 5355.143177091666, 5420.620556561043, 5441.782328706847, 5500.477454641803, 5242.659227150223, 5396.973015134939, 5398.433164517708, 5404.027275090482, 5428.240046393508, 5780.421957804228, 5940.108983652443, 5993.430624090704, 6104.328523862371, 6115.266168059817, 5154.510321519487, 6200.162977997958, 6232.532560057968, 6239.625622462667, 6261.780837670705, 5624.3531993820825, 6249.531285153632, 6255.624662520263, 6267.99712046075, 6306.0225665022, 6123.663198524079, 6142.955697531431, 6143.754249829957, 6145.446909778052, 6149.938500614981, 6245.188125543741, 6254.562180647402, 6267.780627678009, 6312.495000399957, 6322.841928951813, 6264.060390941395, 6272.5922815016875, 6291.96854015727, 6294.370562943669, 6297.622142671455, 6230.470410015108, 6292.811215663537, 6295.370462953668, 6297.149884765589, 6316.431521163117, 6225.782097626561, 6237.376262373727, 6253.812385628438, 6303.243610766645, 6305.464035556937, 6243.687815609202, 6268.1851359323, 6287.339829317947, 6297.874042519215, 6309.558330916791, 4985.5762260208285, 5139.389341930614, 5146.614003949719, 5149.433562308143, 5202.297689811827, 4523.2988886722615, 4525.389072475174, 4554.362389265505, 4590.196715574828, 4609.562091601292, 6111.633302001894, 6116.724747386378, 6159.199304090529, 6162.969185154136, 6171.444569988633, 6303.495720342362, 6334.1765570475545, 6334.778282760081, 6336.429721325103, 6355.777547785898, 5961.956657584992, 5977.0, 6053.7578496860515, 6120.14317995481, 6120.540959428061, 5001.324821149171, 5595.132754423071, 5603.355614104348, 5617.157426385993, 5646.20953066571, 6438.935610643927, 6463.806085817433, 6467.0, 6497.64262965532, 6503.414692677682, 6191.7523299069335, 6204.844878878064, 6225.221847269091, 6226.719797609027, 6291.02489114188, 6479.4816414685765, 6499.382558657109, 6505.804825855232, 6510.056041873807, 6513.706883190173, 6259.405356491126, 6268.028455589391, 6280.7124539470215, 6292.559520833498, 6334.683265836782, 6210.0, 6210.689465526796, 6255.155554000334, 6271.090691849748, 6289.056641503628, 6121.452973575903, 6289.40250676185, 6297.716602752796, 6311.463525600376, 6319.494440444661, 6265.4361107500545, 6284.402981716729, 6289.056641503811, 6301.4643755279485, 6306.873862522815, 4762.714237145782, 5163.27714120031, 5967.433093856077, 6124.197855633957, 6150.7539698411565, 6175.382461753788, 6181.783637572664, 6218.844528886814, 6231.470325022424, 6275.246970363585, 4714.882127946692, 5089.821856235014, 6224.1597384354345, 6227.875442491216, 6250.687465626609], "value": 5836.645618820662, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.6670330768463, 496.42910652749345, 514.8403994761624, 530.607350560585, 533.7918211897363, 42671.0, 45735.77132114339, 45914.54085459145, 45952.54047459525, 45983.31025034627, 45048.0, 45451.77274113625, 45459.31811022837, 45507.0, 45530.77234613831, 9934.950325248381, 10009.89990100097, 10023.498825058754, 10076.546555404988, 10182.981701829833, 10000.89999100007, 10009.149222316075, 10016.298859079867, 10044.19646428284, 10097.444640544767, 10038.297319187623, 10086.89913100867, 10139.188864890792, 10142.492875356204, 10144.797104057914, 10013.449260290718, 10030.297879148462, 10067.49662516875, 10107.140893024029, 10109.848352274721, 9985.101340879355, 9997.250206234561, 10070.496475176213, 10075.445850478221, 10113.797724045478, 42754.0, 43500.78249608763, 43511.78244108759, 43791.0, 44048.339274910584, 3396.677315655009, 3446.638102999174, 3486.755927085105, 3521.3309471200646, 3680.0, 32848.83575582131, 32964.1758956028, 32966.34067318664, 33114.50328245078, 33141.3371732564, 3315.187778994162, 3380.138064793462, 3437.8968630941113, 3449.223924616941, 3464.9133771655656, 539534.0, 541860.0, 545834.0, 549048.2547587276, 550084.0, 66291.66854165698, 66419.33580664132, 66452.66773666101, 66555.66722166455, 66714.33285667178, 36266.8186659065, 36335.27329453396, 36437.63562364395, 38429.0, 38589.0, 17803.0, 18224.271029158685, 18404.723929141073, 18409.631807364047, 18512.0, 13466.797998030037, 13752.518661846987, 13789.310534473438, 13896.51362202318, 13942.163470191821, 19823.801761982482, 20378.59242815165, 20858.687119693215, 20883.477913052295, 20932.895335523226, 7295.671694773748, 7742.225777422325, 8248.381371397169, 8310.792230194173, 8318.916810831935, 916.7753900294471, 958.5303201431249, 990.8464188050864, 1097.5170924793065, 1104.4146602300793, 26582.867085664835, 26676.333091672863, 26804.05155432901, 27415.766290516975, 31545.52681709776, 1074.3070719385953, 1089.4443833644739, 1105.5080489182396, 1121.1423261205184, 1133.7109037195628, 16481.91759041221, 17021.31914723397, 17068.146592670564, 17107.828921710625, 17200.483985480456, 741098.0, 746510.0, 755345.0, 756393.0, 756552.0, 63204.68397657982, 63259.6837015812, 63413.36586634075, 63846.0, 63972.04041939374, 1416.4263473293333, 1430.6709456824988, 1444.6605047813755, 1446.7540518111737, 1453.2370505484494, 26779.598306025036, 31081.844590776902, 31281.530777037908, 32623.510647339834, 32903.8354808234, 55176.72411638077, 55230.44769552414, 55355.0, 55507.0, 55863.720681396335, 615656.0, 618465.0, 619258.0, 620033.0, 620337.0, 28324.433511329247, 28649.427011459236, 28995.13014609565, 29025.564616530348, 29089.7091029087, 50175.74912125416, 51297.743511282206, 51714.22428663498, 51909.0, 51968.740156298976, 40873.795631021654, 42228.155436891706, 42284.788576056926, 43382.56617433785, 44025.339619906365, 41888.162236754484, 41946.7902660497, 42117.57882421259, 43005.0, 43291.0, 35384.646153539165, 35834.462483062256, 39574.60425395824, 41013.79493102516, 41471.37792933048, 33800.323993520484, 37034.629653703116, 37207.627923720414, 37240.813795930844, 37249.0, 27376.0, 27724.0, 27743.583846242727, 27744.44511109807, 27873.860630696716], "value": 21029.305705721257, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.4102205808963, 334.2618384401114, 386.2988675553871, 391.84522113765047, 408.73023804289176, 20796.376108716744, 21273.0, 21923.561528769435, 21990.340289791293, 22041.669374959387, 21456.034478448506, 21572.568548629017, 22123.446913827163, 22208.666869996963, 22249.2212772553, 6039.667818269993, 6100.87798244036, 6232.626042437446, 6295.811125666238, 6296.905546416808, 4457.153140903218, 4680.134175177603, 5533.833984980457, 6146.0, 6257.5619706620555, 5821.796237131702, 6953.756618518353, 6962.756303529378, 6987.580745155282, 6993.055937448456, 5555.916661250064, 6817.625030623314, 6831.2144103428, 6903.620300883449, 6914.481413893953, 6030.155778191057, 6062.363451837582, 6073.908891366633, 6091.5431342649035, 6097.085437184413, 22406.2157824477, 27022.0, 27136.864315678493, 27263.45473090547, 27351.86324068387, 2348.3072493614427, 2387.5224955008894, 2436.6223235398543, 2463.0, 2567.319660290006, 16480.587985300343, 16504.0, 16561.92347497409, 16581.25384357707, 16747.748783768253, 1868.598251375947, 1903.8857668539931, 1904.0955546115483, 1931.7875033746277, 1941.825235728791, 124281.75718242883, 126459.3677031609, 131803.02295465575, 132720.33639831835, 133285.3335733315, 11266.43667816606, 11365.431728413712, 11392.974632283134, 11918.165728398928, 11928.761424771455, 13946.721065578835, 14348.0, 14476.493322733653, 14484.710305794037, 14489.0, 9025.63897444108, 9112.271018318519, 9131.908680913239, 9137.269018478506, 9178.541072946326, 9224.907750922404, 9321.72034838956, 9360.017198194091, 9369.250459963187, 9450.243980481546, 6096.420840020191, 6756.966215168991, 7073.221945585981, 7099.0, 7108.466864985044, 1489.9925500372428, 1617.3530587764753, 1711.4095637005214, 1802.2430579156785, 1940.427573865713, 885.7165706973707, 900.5902314447042, 1014.3305418423953, 1038.9272750907364, 1046.9790604187874, 17690.91154544219, 22040.88979555092, 22152.556948861256, 22190.334289971328, 22447.0, 945.4138434170858, 951.4196340232453, 952.590386133969, 969.486172328667, 971.3928794503436, 11147.38689372076, 11404.771904561861, 11739.530418783153, 11764.99997500222, 11773.470193841298, 619503.0, 620595.0, 623517.8824105851, 627196.0, 671401.0, 87753.56123219471, 104526.47736761268, 141827.87258191136, 146916.0, 147473.0, 988.906053924876, 1008.8083264179783, 1023.3808545829814, 1027.0961553832578, 1039.3296323871061, 19582.60834783268, 19938.828218334496, 20214.583747268498, 20438.28466003683, 20485.69271460959, 56539.86920261654, 57798.0, 58380.708096459246, 58709.82580348454, 59147.81704365974, 69262.65368673124, 87735.8066048354, 88587.0, 88884.0, 90360.0, 8137.430379873352, 8274.089850116363, 8394.580270986304, 8411.915880841358, 8412.158784121539, 11629.709257268636, 12516.687082823002, 13185.802212967004, 13215.810577048112, 13736.450541978209, 11084.833727493933, 11300.321980681185, 11420.885791142315, 11563.595274165364, 11924.403779810802, 9387.718368448957, 11520.251183673034, 11571.826422603499, 11584.478698458759, 11648.242864213798, 9175.954120229357, 11572.305661660328, 11718.355490448108, 11779.469923853618, 12047.879521204675, 8389.447952128876, 8431.241188293083, 8440.788980275542, 8489.10864359258, 8495.32037437016, 10473.538718401322, 10761.600991871006, 11474.94262528682, 11685.240459370114, 11919.0], "value": 10175.456134390963, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.392062690849, 1516.9089854608724, 1698.7197112476442, 1868.7290342900271, 1903.448000079977, 8451.323894088473, 8627.180417860292, 8659.69691060813, 9261.120193581615, 9307.581158847852, 8770.0, 9040.72877813665, 9090.227330676884, 9143.679971201009, 9153.496557689341, 2321.698179236697, 2435.427674496492, 2457.336519139831, 2459.5449841779237, 2463.174836429789, 2400.23192578375, 2408.915687950922, 2430.2101816909576, 2442.9144979925704, 2447.1801946347996, 2396.544656515265, 2419.0928401849305, 2419.346776370379, 2423.1397853761923, 2428.9514209715794, 2001.8898960557165, 2330.9184178553837, 2382.1543352110098, 2393.700787401575, 2394.461246219604, 2380.642903564462, 2389.8207634427313, 2391.175044609607, 2392.6650268962358, 2397.05316400021, 9036.638534458614, 9184.494852783095, 9204.631814727403, 9207.17135457812, 9230.707700921876, 5447.972760136174, 5481.917771233395, 5483.698396588186, 5590.552755779528, 5592.0773072443, 3627.782333060025, 3706.6664000240107, 3740.139767853409, 3770.3967365221706, 3785.3943369061094, 1057.8307470804634, 1130.248384824091, 1131.6887855839627, 1136.352279200856, 1151.5739176504746, 11928.940355298342, 11956.163068585203, 11991.820122698167, 12013.459394327276, 12078.758424831542, 4349.934750978738, 4452.332150177499, 4497.168023915586, 4733.668643194943, 4764.166270902579, 9047.68333108338, 9069.0, 9233.399829011092, 9279.257659387233, 9337.486438245825, 5284.7886084556185, 5292.894142117136, 5360.973195134077, 5382.650127741685, 5400.972995135077, 4606.723596584216, 4701.459332176843, 4904.4605093439695, 5014.924776128361, 5015.0, 3875.8372488253412, 3877.9612203878164, 3940.822662980173, 3981.402789581586, 4001.2597669431248, 1182.4501606752901, 1190.5356910804794, 1196.5931583261558, 1200.9099317551218, 1203.6148432501516, 753.3408267765705, 896.3814967672286, 918.2424499787702, 925.1997022575558, 929.1266209762802, 5369.7583608737705, 6096.603720758225, 6138.0179171332375, 6200.689965501797, 6282.120503129566, 738.4941315199105, 988.17981075707, 990.6730778842965, 1013.6097602423121, 1025.9281850270559, 3250.4636734938945, 3631.745777795582, 3920.980395098063, 4034.9394759078637, 4186.0, 10830.296030757976, 11183.664490065312, 11196.496157672924, 11199.440027998568, 11206.607768728056, 9345.579448924815, 10902.291351062155, 11005.449727513593, 11044.171687123498, 11152.0, 7061.752838650623, 8308.54303013328, 8329.37529685276, 8398.454100483448, 8600.956995215109, 5802.767889284381, 5882.352941176553, 5886.440788125121, 6024.246969128859, 6056.424639659225, 10033.899661003588, 10101.494925253855, 10215.744606384602, 10238.33450825694, 10244.590216391261, 10113.797724045626, 10364.274500785174, 10382.0, 10394.272400932165, 10544.314619549705, 6664.166979127609, 6804.387605115563, 6998.825029374307, 7123.109611298588, 7182.209956904632, 8457.196566326189, 8614.61234244473, 8662.480251184948, 8675.002374726988, 8717.0, 6748.662566871539, 7589.316961473494, 7779.92220077792, 7824.765257042298, 7843.333316668147, 7512.774616761506, 7562.168161502121, 7599.4680372373405, 7627.5042122261875, 7645.961770191114, 7082.787516374517, 7113.181984071898, 7252.419806415369, 7256.310650488195, 7260.67326970277, 4941.827036053721, 5017.172166592617, 5038.2190760432195, 5095.184770436712, 5152.27868098474, 5023.34696489454, 5077.213031980049, 5125.000624878113, 5173.508516690908, 5199.376074871039], "value": 4642.5395891154685, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [248.60595955410673, 306.9232691827042, 314.65388073119567, 317.6315474050102, 318.3410340594966, 5277.736113194339, 5385.542228910537, 5580.274564306645, 5731.0, 5744.741486633101, 4131.5455299916985, 4644.953550464495, 5271.630985830984, 5516.420775818541, 5626.578006649497, 4023.436718859362, 4247.0, 4277.764722940237, 4283.400323954634, 4297.419848320484, 3346.5482159908343, 4210.62104410603, 4281.4097471030045, 4287.5498072702385, 4289.335153051266, 3632.600413954463, 4179.0, 4189.937150942723, 4200.4539409876825, 4228.619424251817, 4208.537060923296, 4211.336522073779, 4236.724612900151, 4241.724287921275, 4253.468316460442, 3028.9091327260217, 3177.364527094567, 3641.4537819327047, 3660.9450858237146, 3662.7985460799646, 4346.456692913386, 4531.342955271467, 4916.827911023132, 4981.907598808473, 5381.973090134564, 4012.578679238696, 4156.8129434175535, 4827.61379089672, 4860.951390486085, 4875.658703890729, 4869.634777391674, 5376.365580865387, 5937.910931336033, 5955.04719244923, 5979.940200597982, 3516.542849429558, 3839.7696138231518, 4006.238814625241, 4013.3578627419765, 4026.5973402659793, 5894.675792831393, 5969.850753731148, 6190.876182476325, 6269.9999999999545, 6277.968610156966, 3223.4520131577688, 3486.6687664671817, 3521.4013617685055, 3986.7441755846817, 4097.733647312974, 3855.9807200963814, 3895.6104389561383, 3983.50206224222, 4089.8159582818844, 4156.334986402222, 4804.543568361, 4819.95180048202, 4821.783019764119, 4841.419029716386, 4856.247281671346, 4699.95300047002, 5886.0, 5977.073553599199, 5984.820455386345, 6024.066269728111, 1159.5419809175328, 1163.8603367595942, 1205.9638210853689, 1433.5412667946157, 1457.672023794659, 914.4284821986258, 968.1867231525553, 976.6679329028165, 994.6170724271063, 1004.7889943111882, 4042.939355909664, 4274.786260686953, 4283.892902677458, 4397.0985947881245, 4631.907361852812, 4194.7767683127995, 4746.454157771831, 4831.637627177975, 5204.906969536364, 5208.64575210448, 4215.3044747616295, 4235.53409124996, 4453.0, 4544.250198717241, 4728.503507131771, 2245.6182448983714, 2356.5609594070056, 2462.7537246275588, 2764.350377661248, 2776.0567602678207, 4387.42963414754, 5306.67505982623, 5327.135502574068, 5334.572769389918, 5338.145896656516, 4368.847090351823, 4440.689151759346, 4837.879053023703, 4899.8195802868095, 5295.808443100272, 5579.939811435815, 5720.599558030981, 5773.0, 5822.73797679097, 5867.413258674183, 5697.4587414195585, 6264.310925798068, 6293.307736149111, 6293.937060629518, 6294.244690637152, 5471.276547887403, 5670.432956704297, 6152.753889844356, 6153.200083989232, 6169.383061693795, 5054.0, 5815.680137592473, 6255.655938923403, 6380.0, 6490.578112422678, 4122.587741225853, 4123.958760412357, 4126.587341265849, 4136.338185890243, 4150.294449943456, 5314.52169304749, 5332.440093790096, 5729.4843464088435, 5885.440883116097, 6185.443310102112, 5873.765049397976, 5913.107805502198, 6026.0659597762415, 6056.878862422639, 6086.113304875325, 6056.304234814259, 6078.300995385587, 6085.208922840003, 6093.928064458106, 6102.908456373247, 5601.103823388238, 5857.765689372548, 5925.9407405925385, 5928.110783382527, 5977.521798256216, 5440.510354068153, 6046.879062418639, 6047.244094488189, 6119.041906590027, 6119.24633914749, 4981.4769449207315, 5337.786488540415, 5623.565990672352, 5961.552883533839, 5972.343042265435], "value": 4133.599302402317, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.5316818722332, 721.9241979592143, 749.6027105634013, 772.4554189296547, 827.2637352756044, 15631.921840390796, 15881.205939703026, 16243.675126497463, 16561.668766624676, 16599.253033613502, 14872.628184295398, 15058.698826023472, 15061.0, 16052.277647505862, 16639.16804159793, 713.8893471511898, 737.1485933746504, 872.2324354568003, 887.4010043220833, 899.9740296062494, 850.90640029597, 870.5603670146598, 870.9520976346298, 871.2376670413388, 872.2803686958284, 905.8097799462121, 924.6809850601531, 927.174814415171, 927.7077720518015, 930.6137952749601, 914.0174312613933, 923.64901337492, 925.2089463508738, 925.8981512033671, 925.9074092590687, 659.6668682315448, 671.2515545167153, 676.2392308652766, 683.3576438148125, 683.5283654278531, 15258.160801155933, 15333.233338333039, 15350.462733804263, 15632.14023228722, 15652.843471565253, 14903.478378256817, 14961.551153465414, 14997.700045999129, 15025.7746133807, 15040.623984400368, 11825.763484730258, 11989.520419183222, 12005.884165432557, 12088.637340879788, 12463.75072498554, 3346.8159251241173, 3927.253821773854, 3970.0, 4011.959880401188, 4050.1697152083752, 124588.0, 125324.0, 132939.33530332288, 134335.6566434333, 137463.31268343693, 10929.617463388744, 11571.6528504145, 11631.76736465266, 11658.70853228676, 11741.706457338463, 23687.407814804767, 23759.7624023761, 23824.285271441884, 23872.92571834237, 23902.043918243424, 8088.757337279891, 8117.512949223065, 8413.747587572383, 8423.115572864883, 8473.830523389497, 4587.79354929029, 4708.270218116198, 4721.008588196449, 4732.361131247238, 4737.6683632146105, 3664.120611053328, 3828.6554210120667, 3830.482884810515, 3833.4824798652385, 3839.347310957144, 676.2088356622763, 696.0994598029813, 706.33251577259, 707.4517249131964, 707.6108140522692, 492.77578701690646, 598.9940100598939, 670.3966430212847, 699.618707804248, 734.372111844376, 9930.354526955725, 9993.350432221881, 10163.542640581192, 10221.182305415548, 10245.538950747234, 581.4737662415521, 608.8492748704863, 609.9695015249308, 700.471144286071, 711.1253158614933, 4824.927626085611, 5001.674891132065, 5003.574696150795, 5004.0, 5006.199008158677, 119363.0, 120681.0, 125443.0, 180437.0, 182440.0, 151914.0, 152949.23525382523, 154763.0, 157793.42206578018, 161406.19296903675, 127719.0, 131658.3668326628, 134139.0, 134960.65039349676, 136112.0, 8390.328773697967, 9527.28545359087, 9603.567839447382, 9620.807583848424, 9635.903640963501, 47571.81070473127, 50460.49539504558, 62034.68982655058, 63423.0486542693, 67742.0, 90298.0, 100466.4976675112, 103091.93816123785, 105226.47386763018, 105697.0, 11327.376994265394, 11560.855279583771, 11892.048636109264, 12111.939440303095, 12361.258324500559, 13239.584780580706, 13901.37443815051, 14013.929930350283, 14028.29858507091, 14168.291585420893, 13016.088873778745, 13065.934670326587, 13152.736945261233, 13198.604041878374, 13328.666783330495, 12570.245785252913, 12700.555480558505, 13025.088243822842, 13070.085094043327, 13077.476900924237, 11948.522059117538, 12739.61781146567, 13079.0, 13929.512467063603, 14322.498712545012, 9362.485063321583, 10563.841542377024, 11300.49147788335, 11403.885961140615, 12278.75442491163, 11450.828237576276, 11739.471723772622, 12046.457909394274, 12130.272183669009, 12168.878311216775], "value": 8101.120978032634, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 116.0, 119.0, 118.0, 118.0, 136.0, 176.0, 118.0, 119.0], "value": 124.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 114.0, 140.0, 111.0, 111.0, 109.0, 109.0, 133.0, 113.0], "value": 119.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 195.0, 195.0, 197.0, 201.0, 195.0, 199.0, 194.0, 199.0, 195.0], "value": 196.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 85.0, 62.0, 63.0, 73.0, 82.0, 106.0, 83.0], "value": 75.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 90.0, 72.0, 70.0, 72.0, 89.0, 70.0, 70.0, 85.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 90.0, 109.0, 136.0, 87.0, 91.0, 87.0, 108.0, 87.0], "value": 101.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 155.0, 143.0, 97.0, 123.0, 127.0, 97.0, 97.0, 96.0, 97.0], "value": 118.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 92.0, 115.0, 134.0, 126.0, 76.0, 74.0, 139.0, 152.0], "value": 109.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 57.0, 62.0, 61.0, 60.0, 62.0, 62.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 76.0, 105.0, 99.0, 69.0, 69.0, 66.0, 65.0, 69.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 83.0, 83.0, 83.0, 86.0, 85.0, 102.0, 101.0, 89.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 152.0, 154.0, 137.0, 141.0, 137.0, 151.0, 138.0, 169.0, 142.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 160.0, 165.0, 161.0, 161.0, 169.0, 159.0, 165.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 67.0, 64.0, 66.0, 66.0], "value": 65.9, "unit": "score"}]}]} 15:20:55 INFO - Return code: 0 15:20:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:20:55 ERROR - # TBPL SUCCESS # 15:20:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:20:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:20:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:20:55 INFO - 2017-01-12 15:20:55.602 screenresolution[1655:10320] starting screenresolution argv=screenresolution get 15:20:55 INFO - 2017-01-12 15:20:55.604 screenresolution[1655:10320] Display 0: 1600x1200x32@60 15:20:55 INFO - 2017-01-12 15:20:55.610 screenresolution[1656:10323] starting screenresolution argv=screenresolution list 15:20:55 INFO - Available Modes on Display 0 15:20:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:20:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:20:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:20:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:20:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:20:55 INFO - Intel Iris: 15:20:55 INFO - Chipset Model: Intel Iris 15:20:55 INFO - Type: GPU 15:20:55 INFO - Bus: Built-In 15:20:55 INFO - VRAM (Dynamic, Max): 1536 MB 15:20:55 INFO - Vendor: Intel (0x8086) 15:20:55 INFO - Device ID: 0x0a2e 15:20:55 INFO - Revision ID: 0x0009 15:20:55 INFO - Displays: 15:20:55 INFO - Display: 15:20:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:20:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:20:55 INFO - Display Serial Number: 1600x1200 60 15:20:55 INFO - Main Display: Yes 15:20:55 INFO - Mirror: Off 15:20:55 INFO - Online: Yes 15:20:55 INFO - Rotation: Supported 15:20:55 INFO - Return code: 0 15:20:55 INFO - Running post-action listener: _resource_record_post_action 15:20:55 INFO - [mozharness: 2017-01-12 23:20:55.844898Z] Finished run-tests step (success) 15:20:55 INFO - Running post-run listener: _resource_record_post_run 15:20:55 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 37790720; Write bytes: 497744896; Read time: 240; Write time: 1586 15:20:55 INFO - TinderboxPrint: CPU usage
54.2% 15:20:55 INFO - TinderboxPrint: I/O read bytes / time
37,790,720 / 240 15:20:55 INFO - TinderboxPrint: I/O write bytes / time
497,744,896 / 1,586 15:20:55 INFO - TinderboxPrint: CPU idle
2,189.7 (45.8%) 15:20:55 INFO - TinderboxPrint: CPU system
971.3 (20.3%) 15:20:55 INFO - TinderboxPrint: CPU user
1,616.8 (33.8%) 15:20:55 INFO - TinderboxPrint: Swap in / out
233,095,168 / 0 15:20:55 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192799232; Write bytes: 188758016; Read time: 17499; Write time: 417 15:20:55 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 35701760; Write bytes: 297698304; Read time: 220; Write time: 1131 15:20:56 INFO - Running post-run listener: _upload_blobber_files 15:20:56 INFO - Blob upload gear active. 15:20:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:20:56 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 15:20:56 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:20:56 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:20:56 INFO - (blobuploader) - INFO - Open directory for files ... 15:20:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:20:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:20:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:57 INFO - (blobuploader) - INFO - Done attempting. 15:20:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:20:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:20:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:58 INFO - (blobuploader) - INFO - Done attempting. 15:20:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:20:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:21:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:00 INFO - (blobuploader) - INFO - Done attempting. 15:21:00 INFO - (blobuploader) - INFO - Iteration through files over. 15:21:00 INFO - Return code: 0 15:21:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:21:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:21:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0a22912217f2671c90870cac46d64195e5bdee6a2be157454b6c55533cfe4790e9308cb65757c58402ad543e7531fac6c6f123126f81f2ce3c707df8601e2f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12ea8ae30bfc5af70030f78f4d894d45ca25ece5a4a8450e356f6795f867cd27a34f081c92cc4e4bcc114bc06c0dd1c5d732cf0738a5f2c6bd5997af843540d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1ee9084d4865704457d503188d525927d36fc0ad98902deda608d300cc5e9011e585fdccf92694161b4ed2618f6637842606ecfa5f615809e965df67cf077f9b"} 15:21:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:21:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:21:00 INFO - Contents: 15:21:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0a22912217f2671c90870cac46d64195e5bdee6a2be157454b6c55533cfe4790e9308cb65757c58402ad543e7531fac6c6f123126f81f2ce3c707df8601e2f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12ea8ae30bfc5af70030f78f4d894d45ca25ece5a4a8450e356f6795f867cd27a34f081c92cc4e4bcc114bc06c0dd1c5d732cf0738a5f2c6bd5997af843540d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1ee9084d4865704457d503188d525927d36fc0ad98902deda608d300cc5e9011e585fdccf92694161b4ed2618f6637842606ecfa5f615809e965df67cf077f9b"} 15:21:00 INFO - Running post-run listener: copy_logs_to_upload_dir 15:21:00 INFO - Copying logs to upload dir... 15:21:00 INFO - mkdir: /builds/slave/test/build/upload/logs 15:21:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.090765 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-01-12 15:21:01.016078) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 15:21:01.021024) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vbPaJVbDZa/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0a22912217f2671c90870cac46d64195e5bdee6a2be157454b6c55533cfe4790e9308cb65757c58402ad543e7531fac6c6f123126f81f2ce3c707df8601e2f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12ea8ae30bfc5af70030f78f4d894d45ca25ece5a4a8450e356f6795f867cd27a34f081c92cc4e4bcc114bc06c0dd1c5d732cf0738a5f2c6bd5997af843540d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1ee9084d4865704457d503188d525927d36fc0ad98902deda608d300cc5e9011e585fdccf92694161b4ed2618f6637842606ecfa5f615809e965df67cf077f9b"} build_url:https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011508 build_url: 'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0a22912217f2671c90870cac46d64195e5bdee6a2be157454b6c55533cfe4790e9308cb65757c58402ad543e7531fac6c6f123126f81f2ce3c707df8601e2f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12ea8ae30bfc5af70030f78f4d894d45ca25ece5a4a8450e356f6795f867cd27a34f081c92cc4e4bcc114bc06c0dd1c5d732cf0738a5f2c6bd5997af843540d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1ee9084d4865704457d503188d525927d36fc0ad98902deda608d300cc5e9011e585fdccf92694161b4ed2618f6637842606ecfa5f615809e965df67cf077f9b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 15:21:01.059298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 15:21:01.059665) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vbPaJVbDZa/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GQk5DqkrxH/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004773 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 15:21:01.111774) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 15:21:01.112122) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 15:21:01.112446) ========= ========= Total master_lag: 8.02 =========