builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0010 starttime: 1482162763.4 results: success (0) buildid: 20161219053239 builduid: ee02c6ea953c4638b62b4f4a1aba2364 revision: be8b4d81d7cf7192f55503f1d627d871402acc7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 07:52:43.398906) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 07:52:43.399733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 07:52:43.400202) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 07:52:43.426273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 07:52:43.426781) ========= 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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 --2016-12-19 07:52:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.02M=0.001s 2016-12-19 07:52:43 (8.02 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092697 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 07:52:43.543638) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 07:52:43.543994) ========= 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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.025097 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 07:52:43.592384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-19 07:52:43.592750) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev be8b4d81d7cf7192f55503f1d627d871402acc7f --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 be8b4d81d7cf7192f55503f1d627d871402acc7f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 2016-12-19 07:52:43,670 truncating revision to first 12 chars 2016-12-19 07:52:43,670 Setting DEBUG logging. 2016-12-19 07:52:43,671 attempt 1/10 2016-12-19 07:52:43,671 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/be8b4d81d7cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-19 07:52:44,659 unpacking tar archive at: mozilla-beta-be8b4d81d7cf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.278721 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-19 07:52:44.895541) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 07:52:44.895865) ========= script_repo_revision: be8b4d81d7cf7192f55503f1d627d871402acc7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 07:52:44.896470) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 07:52:44.896759) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 07:52:44.916933) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-12-19 07:52:44.917324) ========= /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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 07:52:45 INFO - MultiFileLogger online at 20161219 07:52:45 in /builds/slave/test 07:52:45 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 07:52:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:52:45 INFO - {'append_to_log': False, 07:52:45 INFO - 'base_work_dir': '/builds/slave/test', 07:52:45 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:52:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:52:45 INFO - 'branch': 'Mozilla-Beta', 07:52:45 INFO - 'buildbot_json_path': 'buildprops.json', 07:52:45 INFO - 'config_files': ('talos/mac_config.py',), 07:52:45 INFO - 'default_actions': ('clobber', 07:52:45 INFO - 'read-buildbot-config', 07:52:45 INFO - 'download-and-extract', 07:52:45 INFO - 'populate-webroot', 07:52:45 INFO - 'create-virtualenv', 07:52:45 INFO - 'install', 07:52:45 INFO - 'run-tests'), 07:52:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:52:45 INFO - 'download_minidump_stackwalk': True, 07:52:45 INFO - 'download_symbols': 'ondemand', 07:52:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:52:45 INFO - 'tooltool.py': '/tools/tooltool.py', 07:52:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:52:45 INFO - '/tools/misc-python/virtualenv.py')}, 07:52:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:52:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:52:45 INFO - 'installer_path': 'installer.exe', 07:52:45 INFO - 'log_level': 'info', 07:52:45 INFO - 'log_name': 'talos', 07:52:45 INFO - 'log_to_console': True, 07:52:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:52:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:52:45 INFO - 'opt_config_files': (), 07:52:45 INFO - 'pip_index': False, 07:52:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:52:45 INFO - 'cmd': ('bash', 07:52:45 INFO - '-c', 07:52:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:52:45 INFO - 'enabled': True, 07:52:45 INFO - 'halt_on_failure': False, 07:52:45 INFO - 'name': 'check_screen_resolution'},), 07:52:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:52:45 INFO - 'cmd': ('bash', 07:52:45 INFO - '-c', 07:52:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:52:45 INFO - 'enabled': True, 07:52:45 INFO - 'halt_on_failure': False, 07:52:45 INFO - 'name': 'check_screen_resolution'},), 07:52:45 INFO - 'run_cmd_checks_enabled': True, 07:52:45 INFO - 'sps_profile': False, 07:52:45 INFO - 'sps_profile_interval': 0, 07:52:45 INFO - 'suite': 'dromaeojs-e10s', 07:52:45 INFO - 'system_bits': '32', 07:52:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:52:45 INFO - 'title': 't-yosemite-r7-0010', 07:52:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:52:45 INFO - 'use_talos_json': True, 07:52:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:52:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:52:45 INFO - 'work_dir': 'build'} 07:52:45 INFO - [mozharness: 2016-12-19 15:52:45.114002Z] Running clobber step. 07:52:45 INFO - Running pre-action listener: _resource_record_pre_action 07:52:45 INFO - Running main action method: clobber 07:52:45 INFO - rmtree: /builds/slave/test/build 07:52:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:52:47 INFO - Running post-action listener: _resource_record_post_action 07:52:47 INFO - [mozharness: 2016-12-19 15:52:47.110034Z] Finished clobber step (success) 07:52:47 INFO - [mozharness: 2016-12-19 15:52:47.110183Z] Running read-buildbot-config step. 07:52:47 INFO - Running pre-action listener: _resource_record_pre_action 07:52:47 INFO - Running main action method: read_buildbot_config 07:52:47 INFO - Using buildbot properties: 07:52:47 INFO - { 07:52:47 INFO - "project": "", 07:52:47 INFO - "product": "firefox", 07:52:47 INFO - "script_repo_revision": "production", 07:52:47 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 07:52:47 INFO - "repository": "", 07:52:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 07:52:47 INFO - "buildid": "20161219053239", 07:52:47 INFO - "pgo_build": "False", 07:52:47 INFO - "basedir": "/builds/slave/test", 07:52:47 INFO - "buildnumber": 0, 07:52:47 INFO - "slavename": "t-yosemite-r7-0010", 07:52:47 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 07:52:47 INFO - "platform": "yosemite_r7", 07:52:47 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:52:47 INFO - "branch": "mozilla-beta", 07:52:47 INFO - "repo_path": "releases/mozilla-beta", 07:52:47 INFO - "revision": "be8b4d81d7cf7192f55503f1d627d871402acc7f", 07:52:47 INFO - "stage_platform": "macosx64", 07:52:47 INFO - "builduid": "ee02c6ea953c4638b62b4f4a1aba2364", 07:52:47 INFO - "slavebuilddir": "test" 07:52:47 INFO - } 07:52:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 07:52:47 INFO - Running post-action listener: _resource_record_post_action 07:52:47 INFO - [mozharness: 2016-12-19 15:52:47.113507Z] Finished read-buildbot-config step (success) 07:52:47 INFO - [mozharness: 2016-12-19 15:52:47.113616Z] Running download-and-extract step. 07:52:47 INFO - Running pre-action listener: _resource_record_pre_action 07:52:47 INFO - Running main action method: download_and_extract 07:52:47 INFO - mkdir: /builds/slave/test/build/tests 07:52:47 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')]} 07:52:47 INFO - trying https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 07:52:47 INFO - Downloading https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/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 07:52:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/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 07:52:48 INFO - Downloaded 1165 bytes. 07:52:48 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 07:52:48 INFO - Using the following test package requirements: 07:52:48 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 07:52:48 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 07:52:48 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 07:52:48 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 07:52:48 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 07:52:48 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:52:48 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 07:52:48 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 07:52:48 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 07:52:48 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 07:52:48 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 07:52:48 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 07:52:48 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 07:52:48 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 07:52:48 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 07:52:48 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 07:52:48 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 07:52:48 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 07:52:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 07:52:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 07:52:48 INFO - Fetch https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 07:52:48 INFO - Expected file size: 16232607 07:52:56 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 07:52:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 07:52:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 07:52:56 INFO - Fetch https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 07:52:56 INFO - Expected file size: 16232607 07:53:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 07:53:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 07:53:03 INFO - Fetch https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 07:53:03 INFO - Expected file size: 14414089 07:53:04 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')]} 07:53:04 INFO - trying https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.dmg 07:53:04 INFO - Downloading https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 07:53:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/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 07:53:06 INFO - Downloaded 86055742 bytes. 07:53:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.dmg 07:53:06 INFO - mkdir: /builds/slave/test/properties 07:53:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:53:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:53:06 INFO - Contents: 07:53:06 INFO - build_url:https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.dmg 07:53:07 INFO - Running post-action listener: _resource_record_post_action 07:53:07 INFO - Running post-action listener: set_extra_try_arguments 07:53:07 INFO - [mozharness: 2016-12-19 15:53:07.420457Z] Finished download-and-extract step (success) 07:53:07 INFO - [mozharness: 2016-12-19 15:53:07.420584Z] Running populate-webroot step. 07:53:07 INFO - Running pre-action listener: _resource_record_pre_action 07:53:07 INFO - Running main action method: populate_webroot 07:53:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:53:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:53:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:53:07 INFO - '--tppagecycles', 07:53:07 INFO - '7'], 07:53:07 INFO - 'tests': ['tsvgm']}}, 07:53:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:53:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:53:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:53:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:53:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:53:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:53:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:07 INFO - 'talos_options': ['--disable-e10s'], 07:53:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:07 INFO - 'talos_options': ['--disable-e10s'], 07:53:07 INFO - 'tests': ['damp', 'tps']}, 07:53:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:07 INFO - 'tests': ['damp', 'tps']}, 07:53:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:53:07 INFO - 'tests': ['dromaeo_dom']}, 07:53:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:53:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:53:07 INFO - 'tests': ['basic_compositor_video']}, 07:53:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:53:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:53:07 INFO - 'tests': ['a11yr', 07:53:07 INFO - 'ts_paint', 07:53:07 INFO - 'tpaint', 07:53:07 INFO - 'sessionrestore', 07:53:07 INFO - 'sessionrestore_no_auto_restore', 07:53:07 INFO - 'tabpaint']}, 07:53:07 INFO - 'other-e10s': {'tests': ['a11yr', 07:53:07 INFO - 'ts_paint', 07:53:07 INFO - 'tpaint', 07:53:07 INFO - 'sessionrestore', 07:53:07 INFO - 'sessionrestore_no_auto_restore', 07:53:07 INFO - 'tabpaint']}, 07:53:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:53:07 INFO - 'ts_paint', 07:53:07 INFO - 'tpaint', 07:53:07 INFO - 'sessionrestore', 07:53:07 INFO - 'sessionrestore_no_auto_restore', 07:53:07 INFO - 'tabpaint']}, 07:53:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:53:07 INFO - 'ts_paint', 07:53:07 INFO - 'tpaint', 07:53:07 INFO - 'sessionrestore', 07:53:07 INFO - 'sessionrestore_no_auto_restore', 07:53:07 INFO - 'tabpaint']}, 07:53:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:53:07 INFO - 'tests': ['a11yr', 07:53:07 INFO - 'ts_paint', 07:53:07 INFO - 'tpaint', 07:53:07 INFO - 'sessionrestore', 07:53:07 INFO - 'sessionrestore_no_auto_restore', 07:53:07 INFO - 'tabpaint']}, 07:53:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:53:07 INFO - 'tests': ['a11yr', 07:53:07 INFO - 'ts_paint', 07:53:07 INFO - 'tpaint', 07:53:07 INFO - 'sessionrestore', 07:53:07 INFO - 'sessionrestore_no_auto_restore', 07:53:07 INFO - 'tabpaint']}, 07:53:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:53:07 INFO - 'tests': ['tsvgx', 07:53:07 INFO - 'tsvgr_opacity', 07:53:07 INFO - 'tart', 07:53:07 INFO - 'tscrollx', 07:53:07 INFO - 'cart']}, 07:53:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:53:07 INFO - 'tsvgr_opacity', 07:53:07 INFO - 'tart', 07:53:07 INFO - 'tscrollx', 07:53:07 INFO - 'cart']}, 07:53:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:07 INFO - 'talos_options': ['--disable-e10s'], 07:53:07 INFO - 'tests': ['tp5o']}, 07:53:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:07 INFO - 'tests': ['tp5o']}, 07:53:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:07 INFO - 'talos_options': ['--disable-e10s', 07:53:07 INFO - '--xperf_path', 07:53:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:07 INFO - 'tests': ['tp5n']}, 07:53:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:07 INFO - 'talos_options': ['--xperf_path', 07:53:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:07 INFO - 'tests': ['tp5n']}}, 07:53:07 INFO - 'talos.zip': {'path': '', 07:53:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:53:07 INFO - Running post-action listener: _resource_record_post_action 07:53:07 INFO - [mozharness: 2016-12-19 15:53:07.439420Z] Finished populate-webroot step (success) 07:53:07 INFO - [mozharness: 2016-12-19 15:53:07.439551Z] Running create-virtualenv step. 07:53:07 INFO - Running pre-action listener: _resource_record_pre_action 07:53:07 INFO - Running main action method: create_virtualenv 07:53:07 INFO - Creating virtualenv /builds/slave/test/build/venv 07:53:07 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 07:53:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:53:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:53:07 INFO - Using real prefix '/tools/python27' 07:53:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:53:08 INFO - Installing distribute.............................................................................................................................................................................................done. 07:53:11 INFO - Installing pip.................done. 07:53:11 INFO - Return code: 0 07:53:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:53:11 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')]} 07:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:11 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')]} 07:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:11 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 0x100fef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d958b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e03d30>, '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 0x100c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dfbb20>, '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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 07:53:11 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 07:53:11 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 07:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcpaSct6MN/Render', 07:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:11 INFO - 'HOME': '/Users/cltbld', 07:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:11 INFO - 'LOGNAME': 'cltbld', 07:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:11 INFO - 'MOZ_NO_REMOTE': '1', 07:53:11 INFO - 'NO_EM_RESTART': '1', 07:53:11 INFO - 'PAGER': '/bin/cat', 07:53:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:11 INFO - 'PWD': '/builds/slave/test', 07:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:11 INFO - 'SHELL': '/bin/bash', 07:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Z1gxzU4lJ/Listeners', 07:53:11 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 07:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:11 INFO - 'USER': 'cltbld', 07:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:11 INFO - 'XPC_FLAGS': '0x0', 07:53:11 INFO - 'XPC_SERVICE_NAME': '0', 07:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:11 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 07:53:11 INFO - Cleaning up... 07:53:11 INFO - Return code: 0 07:53:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:53:11 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')]} 07:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:11 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')]} 07:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:11 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 0x100fef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d958b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e03d30>, '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 0x100c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dfbb20>, '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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 07:53:11 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 07:53:11 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 07:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcpaSct6MN/Render', 07:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:11 INFO - 'HOME': '/Users/cltbld', 07:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:11 INFO - 'LOGNAME': 'cltbld', 07:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:11 INFO - 'MOZ_NO_REMOTE': '1', 07:53:11 INFO - 'NO_EM_RESTART': '1', 07:53:11 INFO - 'PAGER': '/bin/cat', 07:53:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:11 INFO - 'PWD': '/builds/slave/test', 07:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:11 INFO - 'SHELL': '/bin/bash', 07:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Z1gxzU4lJ/Listeners', 07:53:11 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 07:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:11 INFO - 'USER': 'cltbld', 07:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:11 INFO - 'XPC_FLAGS': '0x0', 07:53:11 INFO - 'XPC_SERVICE_NAME': '0', 07:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:11 INFO - Downloading/unpacking psutil>=3.1.1 07:53:11 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 07:53:11 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 07:53:11 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 07:53:11 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 07:53:11 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 07:53:11 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 07:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:53:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:14 INFO - Installing collected packages: psutil 07:53:14 INFO - Running setup.py install for psutil 07:53:14 INFO - building 'psutil._psutil_osx' extension 07:53:14 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 07:53:15 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 07:53:15 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 07:53:15 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 07:53:15 INFO - building 'psutil._psutil_posix' extension 07:53:15 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 07:53:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:53:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:53:15 INFO - ^ 07:53:15 INFO - 1 warning generated. 07:53:15 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 07:53:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:15 INFO - Successfully installed psutil 07:53:15 INFO - Cleaning up... 07:53:15 INFO - Return code: 0 07:53:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:53:15 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')]} 07:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:15 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')]} 07:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:15 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 0x100fef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d958b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e03d30>, '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 0x100c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dfbb20>, '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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 07:53:15 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 07:53:15 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 07:53:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcpaSct6MN/Render', 07:53:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:15 INFO - 'HOME': '/Users/cltbld', 07:53:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:15 INFO - 'LOGNAME': 'cltbld', 07:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:15 INFO - 'MOZ_NO_REMOTE': '1', 07:53:15 INFO - 'NO_EM_RESTART': '1', 07:53:15 INFO - 'PAGER': '/bin/cat', 07:53:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:15 INFO - 'PWD': '/builds/slave/test', 07:53:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:15 INFO - 'SHELL': '/bin/bash', 07:53:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Z1gxzU4lJ/Listeners', 07:53:15 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 07:53:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:15 INFO - 'USER': 'cltbld', 07:53:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:15 INFO - 'XPC_FLAGS': '0x0', 07:53:15 INFO - 'XPC_SERVICE_NAME': '0', 07:53:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:53:15 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 07:53:15 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 07:53:15 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 07:53:15 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 07:53:15 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 07:53:15 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 07:53:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:53:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:53:18 INFO - Installing collected packages: mozsystemmonitor 07:53:18 INFO - Running setup.py install for mozsystemmonitor 07:53:18 INFO - Successfully installed mozsystemmonitor 07:53:18 INFO - Cleaning up... 07:53:18 INFO - Return code: 0 07:53:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:53:18 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')]} 07:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:18 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')]} 07:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:18 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 0x100fef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d958b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e03d30>, '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 0x100c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dfbb20>, '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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 07:53:18 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 07:53:18 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 07:53:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcpaSct6MN/Render', 07:53:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:18 INFO - 'HOME': '/Users/cltbld', 07:53:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:18 INFO - 'LOGNAME': 'cltbld', 07:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:18 INFO - 'MOZ_NO_REMOTE': '1', 07:53:18 INFO - 'NO_EM_RESTART': '1', 07:53:18 INFO - 'PAGER': '/bin/cat', 07:53:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:18 INFO - 'PWD': '/builds/slave/test', 07:53:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:18 INFO - 'SHELL': '/bin/bash', 07:53:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Z1gxzU4lJ/Listeners', 07:53:18 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 07:53:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:18 INFO - 'USER': 'cltbld', 07:53:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:18 INFO - 'XPC_FLAGS': '0x0', 07:53:18 INFO - 'XPC_SERVICE_NAME': '0', 07:53:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:19 INFO - Downloading/unpacking jsonschema==2.5.1 07:53:19 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 07:53:19 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 07:53:19 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 07:53:19 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 07:53:19 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 07:53:19 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 07:53:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:53:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:53:21 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 07:53:21 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 07:53:21 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 07:53:21 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 07:53:21 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 07:53:21 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 07:53:22 INFO - Downloading functools32-3.2.3-2.tar.gz 07:53:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:53:22 INFO - warning: no files found matching '*.txt' 07:53:22 INFO - no previously-included directories found matching 'build' 07:53:22 INFO - no previously-included directories found matching 'dist' 07:53:22 INFO - no previously-included directories found matching '.git*' 07:53:22 INFO - Installing collected packages: jsonschema, functools32 07:53:22 INFO - Running setup.py install for functools32 07:53:22 INFO - warning: no files found matching '*.txt' 07:53:22 INFO - no previously-included directories found matching 'build' 07:53:22 INFO - no previously-included directories found matching 'dist' 07:53:22 INFO - no previously-included directories found matching '.git*' 07:53:22 INFO - Successfully installed jsonschema functools32 07:53:22 INFO - Cleaning up... 07:53:22 INFO - Return code: 0 07:53:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100fef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d958b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e03d30>, '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 0x100c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dfbb20>, '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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 07:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcpaSct6MN/Render', 07:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:22 INFO - 'HOME': '/Users/cltbld', 07:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:22 INFO - 'LOGNAME': 'cltbld', 07:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:22 INFO - 'MOZ_NO_REMOTE': '1', 07:53:22 INFO - 'NO_EM_RESTART': '1', 07:53:22 INFO - 'PAGER': '/bin/cat', 07:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:22 INFO - 'PWD': '/builds/slave/test', 07:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:22 INFO - 'SHELL': '/bin/bash', 07:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Z1gxzU4lJ/Listeners', 07:53:22 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 07:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:22 INFO - 'USER': 'cltbld', 07:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:22 INFO - 'XPC_FLAGS': '0x0', 07:53:22 INFO - 'XPC_SERVICE_NAME': '0', 07:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:53:22 INFO - Cleaning up... 07:53:22 INFO - Return code: 0 07:53:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100fef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d958b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e03d30>, '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 0x100c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dfbb20>, '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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 07:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcpaSct6MN/Render', 07:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:22 INFO - 'HOME': '/Users/cltbld', 07:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:22 INFO - 'LOGNAME': 'cltbld', 07:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:22 INFO - 'MOZ_NO_REMOTE': '1', 07:53:22 INFO - 'NO_EM_RESTART': '1', 07:53:22 INFO - 'PAGER': '/bin/cat', 07:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:22 INFO - 'PWD': '/builds/slave/test', 07:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:22 INFO - 'SHELL': '/bin/bash', 07:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Z1gxzU4lJ/Listeners', 07:53:22 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 07:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:22 INFO - 'USER': 'cltbld', 07:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:22 INFO - 'XPC_FLAGS': '0x0', 07:53:22 INFO - 'XPC_SERVICE_NAME': '0', 07:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:22 INFO - Downloading/unpacking blobuploader==1.2.4 07:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:25 INFO - Downloading blobuploader-1.2.4.tar.gz 07:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:53:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:53:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:53:26 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 07:53:26 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 07:53:26 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 07:53:26 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 07:53:26 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 07:53:26 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 07:53:26 INFO - Downloading docopt-0.6.1.tar.gz 07:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:53:26 INFO - Installing collected packages: blobuploader, requests, docopt 07:53:26 INFO - Running setup.py install for blobuploader 07:53:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:53:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:53:26 INFO - Running setup.py install for requests 07:53:27 INFO - Running setup.py install for docopt 07:53:27 INFO - Successfully installed blobuploader requests docopt 07:53:27 INFO - Cleaning up... 07:53:27 INFO - Return code: 0 07:53:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:27 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')]} 07:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:27 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')]} 07:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:27 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 0x100fef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d958b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e03d30>, '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 0x100c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dfbb20>, '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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 07:53:27 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 07:53:27 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 07:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcpaSct6MN/Render', 07:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:27 INFO - 'HOME': '/Users/cltbld', 07:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:27 INFO - 'LOGNAME': 'cltbld', 07:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:27 INFO - 'MOZ_NO_REMOTE': '1', 07:53:27 INFO - 'NO_EM_RESTART': '1', 07:53:27 INFO - 'PAGER': '/bin/cat', 07:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:27 INFO - 'PWD': '/builds/slave/test', 07:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:27 INFO - 'SHELL': '/bin/bash', 07:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Z1gxzU4lJ/Listeners', 07:53:27 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 07:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:27 INFO - 'USER': 'cltbld', 07:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:27 INFO - 'XPC_FLAGS': '0x0', 07:53:27 INFO - 'XPC_SERVICE_NAME': '0', 07:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:53:27 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-zB5Sm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:53:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-8Adyp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:53:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-qpeqb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:53:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-vGG3gS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:53:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-PCI2e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:53:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-SpNR1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:53:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-OIMau4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:53:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-2h_PQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:53:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-U7Jmhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:53:28 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-IJW1Zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:53:29 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-LVpdNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:53:29 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-lt16B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:53:29 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-ZpsWNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:53:29 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-G8xIri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:29 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-ekr5il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:53:29 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-8TRmmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:53:29 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-hkpzkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:53:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:53:29 INFO - Running setup.py install for manifestparser 07:53:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:53:29 INFO - Running setup.py install for mozcrash 07:53:30 INFO - Running setup.py install for mozdebug 07:53:30 INFO - Running setup.py install for mozdevice 07:53:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:53:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:53:30 INFO - Running setup.py install for mozfile 07:53:30 INFO - Running setup.py install for mozhttpd 07:53:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:53:30 INFO - Running setup.py install for mozinfo 07:53:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:53:30 INFO - Running setup.py install for mozInstall 07:53:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:53:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:53:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:53:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:53:31 INFO - Running setup.py install for mozleak 07:53:31 INFO - Running setup.py install for mozlog 07:53:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:53:31 INFO - Running setup.py install for moznetwork 07:53:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:53:31 INFO - Running setup.py install for mozprocess 07:53:31 INFO - Running setup.py install for mozprofile 07:53:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:53:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:53:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:53:31 INFO - Running setup.py install for mozrunner 07:53:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:53:32 INFO - Running setup.py install for mozscreenshot 07:53:32 INFO - Running setup.py install for moztest 07:53:32 INFO - Running setup.py install for mozversion 07:53:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:53:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:53:32 INFO - Cleaning up... 07:53:32 INFO - Return code: 0 07:53:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53: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')]} 07:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d958b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e03d30>, '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 0x100c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dfbb20>, '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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 07:53:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:53:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcpaSct6MN/Render', 07:53:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:32 INFO - 'HOME': '/Users/cltbld', 07:53:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:32 INFO - 'LOGNAME': 'cltbld', 07:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:32 INFO - 'MOZ_NO_REMOTE': '1', 07:53:32 INFO - 'NO_EM_RESTART': '1', 07:53:32 INFO - 'PAGER': '/bin/cat', 07:53:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:32 INFO - 'PWD': '/builds/slave/test', 07:53:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:32 INFO - 'SHELL': '/bin/bash', 07:53:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Z1gxzU4lJ/Listeners', 07:53:32 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 07:53:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:32 INFO - 'USER': 'cltbld', 07:53:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:32 INFO - 'XPC_FLAGS': '0x0', 07:53:32 INFO - 'XPC_SERVICE_NAME': '0', 07:53:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:53:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-NtXd4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:53:33 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)) 07:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:53:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-WnqFUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:53:33 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)) 07:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:53:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-NL54FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:53:33 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)) 07:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:53:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-zC6wra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:53:33 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)) 07:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:53:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-NIybqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:53:33 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)) 07:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:53:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-pXXnV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:53:33 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)) 07:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:53:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-ys8Oa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:53:33 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)) 07:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:53:33 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-OLtAgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:53:34 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)) 07:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:53:34 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-ml3sr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:53:34 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)) 07:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:53:34 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-p_MJJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:53:34 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)) 07:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:53:34 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-PxL_Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:53:34 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)) 07:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:53:34 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-mgSpCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:53:34 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)) 07:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:53:34 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-NpkgWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:53:34 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)) 07:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:53:34 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-KaJyFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:53:34 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)) 07:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:34 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-UWadNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:34 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)) 07:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:53:34 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-1asLO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:53:34 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)) 07:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:53:34 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-RpjkkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:53:35 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)) 07:53:35 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)) 07:53:35 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)) 07:53:35 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)) 07:53:35 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)) 07:53:35 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)) 07:53:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:53:35 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 07:53:35 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 07:53:35 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 07:53:35 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 07:53:35 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 07:53:35 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 07:53:37 INFO - Downloading blessings-1.6.tar.gz 07:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:53:37 INFO - Installing collected packages: blessings 07:53:37 INFO - Running setup.py install for blessings 07:53:37 INFO - Successfully installed blessings 07:53:37 INFO - Cleaning up... 07:53:38 INFO - Return code: 0 07:53:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:38 INFO - Reading from file tmpfile_stdout 07:53:38 INFO - Current package versions: 07:53:38 INFO - blessings == 1.6 07:53:38 INFO - blobuploader == 1.2.4 07:53:38 INFO - docopt == 0.6.1 07:53:38 INFO - functools32 == 3.2.3-2 07:53:38 INFO - jsonschema == 2.5.1 07:53:38 INFO - manifestparser == 1.1 07:53:38 INFO - mozInstall == 1.12 07:53:38 INFO - mozcrash == 0.17 07:53:38 INFO - mozdebug == 0.1 07:53:38 INFO - mozdevice == 0.48 07:53:38 INFO - mozfile == 1.2 07:53:38 INFO - mozhttpd == 0.7 07:53:38 INFO - mozinfo == 0.9 07:53:38 INFO - mozleak == 0.1 07:53:38 INFO - mozlog == 3.4 07:53:38 INFO - moznetwork == 0.27 07:53:38 INFO - mozprocess == 0.23 07:53:38 INFO - mozprofile == 0.28 07:53:38 INFO - mozrunner == 6.12 07:53:38 INFO - mozscreenshot == 0.1 07:53:38 INFO - mozsystemmonitor == 0.3 07:53:38 INFO - moztest == 0.7 07:53:38 INFO - mozversion == 1.4 07:53:38 INFO - psutil == 3.1.1 07:53:38 INFO - requests == 1.2.3 07:53:38 INFO - wsgiref == 0.1.2 07:53:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:38 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')]} 07:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:38 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')]} 07:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:38 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 0x100fef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d958b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e03d30>, '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 0x100c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dfbb20>, '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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 07:53:38 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 07:53:38 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 07:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcpaSct6MN/Render', 07:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:38 INFO - 'HOME': '/Users/cltbld', 07:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:38 INFO - 'LOGNAME': 'cltbld', 07:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:38 INFO - 'MOZ_NO_REMOTE': '1', 07:53:38 INFO - 'NO_EM_RESTART': '1', 07:53:38 INFO - 'PAGER': '/bin/cat', 07:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:38 INFO - 'PWD': '/builds/slave/test', 07:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:38 INFO - 'SHELL': '/bin/bash', 07:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Z1gxzU4lJ/Listeners', 07:53:38 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 07:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:38 INFO - 'USER': 'cltbld', 07:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:38 INFO - 'XPC_FLAGS': '0x0', 07:53:38 INFO - 'XPC_SERVICE_NAME': '0', 07:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:38 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)) 07:53:38 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)) 07:53:38 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)) 07:53:38 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)) 07:53:38 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)) 07:53:38 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)) 07:53:38 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)) 07:53:38 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)) 07:53:38 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)) 07:53:38 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)) 07:53:38 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)) 07:53:38 INFO - Cleaning up... 07:53:38 INFO - Return code: 0 07:53:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:53:38 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')]} 07:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:38 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')]} 07:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:38 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 0x100fef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d958b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e03d30>, '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 0x100c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dfbb20>, '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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 07:53:38 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 07:53:38 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 07:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcpaSct6MN/Render', 07:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:38 INFO - 'HOME': '/Users/cltbld', 07:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:38 INFO - 'LOGNAME': 'cltbld', 07:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:38 INFO - 'MOZ_NO_REMOTE': '1', 07:53:38 INFO - 'NO_EM_RESTART': '1', 07:53:38 INFO - 'PAGER': '/bin/cat', 07:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:38 INFO - 'PWD': '/builds/slave/test', 07:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:38 INFO - 'SHELL': '/bin/bash', 07:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Z1gxzU4lJ/Listeners', 07:53:38 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 07:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:38 INFO - 'USER': 'cltbld', 07:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:38 INFO - 'XPC_FLAGS': '0x0', 07:53:38 INFO - 'XPC_SERVICE_NAME': '0', 07:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:53:38 INFO - Cleaning up... 07:53:38 INFO - Return code: 0 07:53:38 INFO - Running post-action listener: _resource_record_post_action 07:53:38 INFO - Running post-action listener: _start_resource_monitoring 07:53:38 INFO - Starting resource monitoring. 07:53:38 INFO - [mozharness: 2016-12-19 15:53:38.887878Z] Finished create-virtualenv step (success) 07:53:38 INFO - [mozharness: 2016-12-19 15:53:38.888919Z] Running install step. 07:53:38 INFO - Running pre-action listener: _resource_record_pre_action 07:53:38 INFO - Running main action method: install 07:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:39 INFO - Reading from file tmpfile_stdout 07:53:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:53:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:53:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:53:39 INFO - Reading from file tmpfile_stdout 07:53:39 INFO - Output received: 07:53:39 INFO - Usage: mozinstall [options] installer 07:53:39 INFO - Options: 07:53:39 INFO - -h, --help show this help message and exit 07:53:39 INFO - -d DEST, --destination=DEST 07:53:39 INFO - Directory to install application into. [default: 07:53:39 INFO - "/builds/slave/test"] 07:53:39 INFO - --app=APP Application being installed. [default: firefox] 07:53:39 INFO - mkdir: /builds/slave/test/build/application 07:53:39 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'] 07:53:39 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 07:54:01 INFO - Reading from file tmpfile_stdout 07:54:01 INFO - Output received: 07:54:01 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:54:01 INFO - Running post-action listener: _resource_record_post_action 07:54:01 INFO - [mozharness: 2016-12-19 15:54:01.365368Z] Finished install step (success) 07:54:01 INFO - [mozharness: 2016-12-19 15:54:01.365529Z] Running run-tests step. 07:54:01 INFO - Running pre-action listener: _resource_record_pre_action 07:54:01 INFO - Running main action method: run_tests 07:54:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:54:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:54:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:54:01 INFO - 2016-12-19 07:54:01.380 screenresolution[2420:128896] starting screenresolution argv=screenresolution get 07:54:01 INFO - 2016-12-19 07:54:01.383 screenresolution[2420:128896] Display 0: 1600x1200x32@60 07:54:01 INFO - 2016-12-19 07:54:01.389 screenresolution[2421:128899] starting screenresolution argv=screenresolution list 07:54:01 INFO - Available Modes on Display 0 07:54:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:54:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:54:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:54:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:54:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:54:01 INFO - Intel Iris: 07:54:01 INFO - Chipset Model: Intel Iris 07:54:01 INFO - Type: GPU 07:54:01 INFO - Bus: Built-In 07:54:01 INFO - VRAM (Dynamic, Max): 1536 MB 07:54:01 INFO - Vendor: Intel (0x8086) 07:54:01 INFO - Device ID: 0x0a2e 07:54:01 INFO - Revision ID: 0x0009 07:54:01 INFO - Displays: 07:54:01 INFO - Display: 07:54:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:54:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:54:01 INFO - Display Serial Number: 1600x1200 60 07:54:01 INFO - Main Display: Yes 07:54:01 INFO - Mirror: Off 07:54:01 INFO - Online: Yes 07:54:01 INFO - Rotation: Supported 07:54:01 INFO - Return code: 0 07:54:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:54:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:54:01 INFO - Python 2.7.3 07:54:01 INFO - Return code: 0 07:54:01 INFO - grabbing minidump binary from tooltool 07:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:01 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 0x100e03d30>, '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 0x100c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dfbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:54:01 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 07:54:01 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 07:54:01 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 07:54:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:54:01 INFO - Return code: 0 07:54:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:54:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:54:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:54:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:54:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:54:01 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/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--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 07:54:01 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/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0010 --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 07:54:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcpaSct6MN/Render', 07:54:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:01 INFO - 'HOME': '/Users/cltbld', 07:54:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:01 INFO - 'LOGNAME': 'cltbld', 07:54:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:54:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:01 INFO - 'MOZ_NO_REMOTE': '1', 07:54:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:54:01 INFO - 'NO_EM_RESTART': '1', 07:54:01 INFO - 'PAGER': '/bin/cat', 07:54:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:01 INFO - 'PWD': '/builds/slave/test', 07:54:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:54:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:01 INFO - 'SHELL': '/bin/bash', 07:54:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Z1gxzU4lJ/Listeners', 07:54:01 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 07:54:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:01 INFO - 'USER': 'cltbld', 07:54:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:01 INFO - 'XPC_FLAGS': '0x0', 07:54:01 INFO - 'XPC_SERVICE_NAME': '0', 07:54:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:01 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/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--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 07:54:01 INFO - mozversion application_buildid: 20161219053239 07:54:01 INFO - mozversion application_changeset: be8b4d81d7cf7192f55503f1d627d871402acc7f 07:54:01 INFO - mozversion application_display_name: Firefox 07:54:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:54:01 INFO - mozversion application_name: Firefox 07:54:01 INFO - mozversion application_remotingname: firefox 07:54:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:54:01 INFO - mozversion application_vendor: Mozilla 07:54:01 INFO - mozversion application_version: 51.0 07:54:01 INFO - mozversion platform_buildid: 20161219053239 07:54:01 INFO - mozversion platform_changeset: be8b4d81d7cf7192f55503f1d627d871402acc7f 07:54:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:54:01 INFO - mozversion platform_version: 51.0 07:54:01 INFO - using testdate: 1482162841 07:54:01 INFO - actual date: 1482162841 07:54:01 INFO - starting webserver on 'localhost:60353' 07:54:01 INFO - SUITE-START | Running 2 tests 07:54:01 INFO - TEST-START | dromaeo_css 07:54:01 INFO - operating with platform_type : mac_ 07:54:01 INFO - Initialising browser for dromaeo_css test... 07:54:02 INFO - TEST-INFO | started process 2431 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpnQGW_E/profile http://localhost:60353/getInfo.html) 07:54:04 INFO - PROCESS | 2431 | __metrics Screen width/height:1600/1200 07:54:04 INFO - PROCESS | 2431 | colorDepth:24 07:54:04 INFO - PROCESS | 2431 | Browser inner width/height: 1024/689 07:54:04 INFO - PROCESS | 2431 | __metrics 07:54:04 ERROR - PROCESS | 2431 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 07:54:05 INFO - TEST-INFO | 2431: exit 0 07:54:05 INFO - Browser initialized. 07:54:05 INFO - Running cycle 1/1 for dromaeo_css test... 07:54:05 INFO - TEST-INFO | started process 2435 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpnQGW_E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:17 INFO - PROCESS | 2435 | RSS: Main: 174772224 07:54:17 INFO - PROCESS | 2435 | 07:55:06 INFO - PROCESS | 2435 | 1482162906984 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] 07:57:18 INFO - PROCESS | 2435 | Cycle 1(1): loaded http://localhost:60353/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60353/tests/dromaeo/cssquery-ext.html) 07:57:20 INFO - PROCESS | 2435 | RSS: Main: 183975936 07:57:20 INFO - PROCESS | 2435 | 08:00:22 INFO - PROCESS | 2435 | Cycle 1(1): loaded http://localhost:60353/tests/dromaeo/cssquery-ext.html (next: http://localhost:60353/tests/dromaeo/cssquery-jquery.html) 08:00:23 INFO - PROCESS | 2435 | RSS: Main: 198750208 08:00:23 INFO - PROCESS | 2435 | 08:03:24 INFO - PROCESS | 2435 | Cycle 1(1): loaded http://localhost:60353/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60353/tests/dromaeo/cssquery-mootools.html) 08:03:25 INFO - PROCESS | 2435 | RSS: Main: 200667136 08:03:25 INFO - PROCESS | 2435 | 08:06:27 INFO - PROCESS | 2435 | Cycle 1(1): loaded http://localhost:60353/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60353/tests/dromaeo/cssquery-prototype.html) 08:06:27 INFO - PROCESS | 2435 | RSS: Main: 205066240 08:06:27 INFO - PROCESS | 2435 | 08:09:30 INFO - PROCESS | 2435 | Cycle 1(1): loaded http://localhost:60353/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60353/tests/dromaeo/cssquery-yui.html) 08:09:31 INFO - PROCESS | 2435 | RSS: Main: 207081472 08:09:31 INFO - PROCESS | 2435 | 08:12:34 INFO - PROCESS | 2435 | Cycle 1(1): loaded http://localhost:60353/tests/dromaeo/cssquery-yui.html (next: http://localhost:60353/tests/dromaeo/cssquery-dojo.html) 08:12:34 INFO - PROCESS | 2435 | RSS: Main: 207904768 08:12:34 INFO - PROCESS | 2435 | 08:12:34 INFO - PROCESS | 2435 | __start_tp_report 08:12:34 INFO - PROCESS | 2435 | _x_x_mozilla_page_load 08:12:34 INFO - PROCESS | 2435 | _x_x_mozilla_page_load_details 08:12:34 INFO - PROCESS | 2435 | |i|pagename|runs| 08:12:34 INFO - PROCESS | 2435 | |0;dojo.html;3552.3428165789314;3559.893203203904;3578;3584.139806446454;3611.295797319524;6024.397560243973;6122.295935967365;6140.907886381702;6155.9076613850775;6161.753529858812;6088.969555152229;6118.174046503721;6164.445199932005;6205.720742566584;6210.813675589739;5452.863678408042;5503.174523821439;5527.474889885474;5568;5608.859778505529;5567;5581.995240856644;5588.804391846286;5594.13290939905;5601;5445.1832225166345;5454;5549.306336707911;5563.805266815662;5579.497845193931;4704.435467743892;5309.203619457093;5483.369412517552;5495.175723641446;5518.227448157221;5348.465153484621;5445.264889239941;5496.4503549645115;5511.614187006911;5525.917111243334;4765.904681906377;5972.134040564138;6009.278886533601;6103.664298463583;6189.442950134509;6400.007998760199;6411.3909178627955;6417.775377861799;6420.390062944013;6437.485001199892;6503.93496065038;6522.869542609169;6547.803565893031;6549;6556.475481961432;6085.300190478108;6109.920916985209;6115.483736156547;6145.692715364214;6235.87528249437;6644.60132392058;6656.900146497806;6681.966590167018;6682.264950855402;6686.866262674719;6302.338254483213;6304.085907543381;6304.432601065834;6309.463695585927;6319.0837328587095;5933.554983376264;6212.316645169028;6317.936820631735;6354.237491500957;6488.221413430324;6217.720202590895;6304.873902522016;6370.617762934239;6385.233771947396;6388.041793730978;6342.746290148435;6350.428461438492;6351.460125889351;6360.332165122595;6366.458850997625;4282.207791558571;5146.87132821675;5166.328377310925;5196.53231209193;5238.764255608507;4630.907381852344;4633.698809577367;4672.486026537078;4708.882277943078;4748.572628463386;6156.07658851167;6213.440790328892;6228.5951413158;6246.281677607042;6255.374462553708;6301.149344838388;6335.524835637346;6355.30091689923;6502.479801615859;6529.216494020748;5192.480751924777;5410.431904650034;6152.630842149485;6190.0714892765545;6215.378462153749;4335.328024156261;5372.91940620891;5799.449052340021;5807.0998995155815;5808.983427900101;6505.447037001908;6545.083688283549;6693.531452798355;6743.055972163901;6754.425873800684;5489.890202196014;5617.74720137603;6320.873582528232;6369.9681501592195;6517.902231466626;6650.068990341259;6723.226828914541;6730.562513436611;6734.528582999339;6749.493787965824;6214.036824292242;6355.682215889095;6399.424051835357;6416.422521973045;6424.743010279536;4938.901221975469;6258.249010118815;6321;6364.204474440695;6513.381228783258;6303.05454181858;6338.334474880071;6339.112524246517;6346.301906790157;6349.841253968688;5889.293284805851;6278.905816412849;6315.084312774714;6333.240011198685;6345.650989195638;6067.453929146398;6107.249501910372;6117.279373342116;6186.845328866814;6195.473384762166;6270.905936410866;6301.495880329654;6319.557630965788;6332.0818481320875;6352.555321127662;4923.5814955729165;6216.875662486635;6221.377862213742;6231.096491008869;6233.75064997395 08:12:34 INFO - PROCESS | 2435 | |1;ext.html;500.3745318352062;510.1098582972711;519.5272302204993;536.1769683535772;559.1165957786698;40575.39136912945;41841;42011;44998.10003799922;45027.77486112565;36797.816010919974;44237.336439953426;44477.8880527987;44607;44828.55171448285;10125.645602403918;10187.439690817002;10313.84529232062;10327.12219461343;10329.225308101884;10127.898721012805;10151.23865710071;10231.897681023207;10241.692749217535;10253.025962533547;10220.386776793417;10228.948855255714;10260;10264.127549158331;10273.897261027369;10068;10172.44051577163;10218.131458826008;10233.130183934412;10242.28304018719;10082.143017843493;10171;10179.949100254451;10181.28730988831;10208.336458130198;40423.393649095284;42102.57897421017;42195.578044219474;42514.36228456576;42539.574604253874;3294.3246634439884;3560.893173204782;3714.814259287025;3750.5686846012786;4073.796310184479;29684.8515757422;30089.398212035638;30415.39169216603;30485.695143048506;32285;3355.4295769719206;3375.8143302118374;3387.8814241501427;3402.727781777452;3447.9310413791836;492530.53734731453;497641;498721;499132.9999999964;501967;34286.314273714386;34448;49242.50757492451;59426.70286648626;59978.400215998154;35695.4645680315;36050.81974590163;36139;36169;36266.09334766599;15510.457134000257;15731.44939927097;15744.527664169864;15752;15758.606034848992;13143.079984401;13300.73398532024;13337.333133343489;13341.533046343526;13368.6657833553;8033.517988920684;8039.758807235792;8050;8093.473924194908;8124.918750812534;3304.603447586305;3351.631320554737;3369.8652053917567;3377.8142202178624;3417.5898892133105;876.3909083187251;946.5929650250458;982.8181786369545;1064.856244406995;1153.2561497834017;25275.62086568703;29585.964491242703;30314.242143946576;30712.232194195323;31262.374752504824;990.4156547636785;1027.701966429742;1114.169943392178;1144.841972881125;1156.8438260834848;15101.848981510264;15484;15558;15841;15865.04809711421;1018657;1038974;1045543;1045729;1050523;55149.44850551523;56484;56693.43306566964;56931.71534142303;56953.71523142441;1355.600097971101;1370.287450525721;1383.3429121167364;1416.732024837785;1424.622475044114;25512.23463296104;28927;29674;30318.545221822133;30783.53824692676;48907.02185956332;49262.26106608332;49284.2607360897;49405.50594494009;49484.50515494943;645563;651827;652887;654370;655638;22481.98831052574;27101.59347609748;27229.455410892067;27274.727252727218;27475.31311717223;44207.33688994732;44449.55550444584;44869;45092.54907450883;45472;33602.15994600154;35805.74679886192;36365.81817090898;37218.44172337363;38668.80665596654;37238.8138059308;37371;37465.81267093647;37752.62247377491;37924.43113353357;33814.830925845214;34808.82595587006;36823.815880920425;38374.23251535009;39955.800220999874;29197.416051679273;32788;34482.137946551535;34859.47710784391;35141.82429087838;25800.483990320463;26232;26424.412066078217;26789.732102678725;26827.463450730487 08:12:34 INFO - PROCESS | 2435 | |2;jquery.html;362.4418395670667;384.8422146919763;395.1898607853899;399.38295333709414;413.8510136350913;20405.897970510145;21943.341699749013;22034.559308813856;22214.55570888581;22354.66468002981;20977.475563110893;20992.320614350854;22534.887325563348;23507.294781156594;23516.29451116465;6227.968860155693;7375.815604609874;7377.336039756421;7393.667284972189;7443.739469118582;6939.0979172707475;7083.822904427405;7085.291470852925;7090.29097090292;7294.197638259787;6351.936480635204;6587.011948207759;6741.831454213635;6773.458123350145;7052.04797352356;7076.469264805134;7119.252478489736;7160.677769500333;7283.417326613885;7296.0515133032895;6753.29090445506;6932.202796678396;6933.514653974224;6962.756303529352;7027.332403421718;29414.558781618292;29828.403431931456;29958.85020574905;30081.247968800737;30098;2491.875406229681;2497.21337778601;2670.34300870635;2833.5749637554327;2920.9123726288035;17574.912125439292;17603.647927041515;17686.91156544222;18125.909370453195;18191.4542563722;2009.6635737234722;2090.874547527153;2146.8389870759756;2184.432047667618;2256.988715056414;97257.51371243098;141188.29405852905;150185.24907375392;150414;153665;19531.730437521517;21404.36125858608;22174.889125554593;22891.542169156855;23054.538909222058;30444.086677399715;37415.62584374121;37593;38225;38266.23467530689;11445.54217831294;11490.161574148096;11672.70818229551;11808.46861891217;12008.339541325311;9734.172595329335;9760.658376956773;9770.218382529381;9886.209103271722;9925.255605829592;10195.082442580204;10405.895941040493;10427.170203516556;10497.895021049844;10627.946860265649;3975.5458515283844;4047.6964227683043;4063.837446502107;4063.959360406417;4129.958700413017;775.8564665536894;816.6896579299947;831.9376046796393;866.5234121233296;902.9413088149381;21466.78533214648;21906.671399929015;22321.995510201756;22477.55044899093;22621.886890565773;911.3984770051734;960.2605993385055;974.0843607009389;975.3221511049752;1051.321897376188;11534.59628912984;11628.452852426828;11694.298342099331;11767.646970590897;11848.348340841336;635936;642096;645446;658430;661762;93167.5341623301;129206;134938;136815.31592341975;137229;942.3780304998668;976.6191185437685;980.1423754215061;1025.190099821148;1041.739565108723;19444.416667499998;19685.80314196897;19918;19966.401007969784;20131.094100765207;43800;55750.72124639351;56701;58195.70902145462;58877.70561147167;64910.67544662247;81976.18023819686;82029.58985205035;84796.57601711951;86258;8150.592470376576;8319.334453243848;8343.374246931384;8455.239028487465;8488.448250863674;10742.624008159677;12252.938735306267;12987.41556629935;13090.214587124803;13131.934340328236;11004.229703920648;11114.833277500682;11285.097192224439;11556.133290003452;11693.356865372487;10153.746156346151;10379.896201037893;10651.520681569504;10981.3960232188;11271.887281127412;8877.245434137913;10261.846072308772;11501.712457188303;11612.187146899636;11992.700182495508;8041.276285134366;8198.795030124294;8322.6670933162;8404.537750423786;8433.325333973145;9369.203617692572;11410.885891140982;11442.656720298404;11623.476943537393;11686.18196726255 08:12:34 INFO - PROCESS | 2435 | |3;mootools.html;1519.9620009499765;1538.5845821628157;1761.321891071937;1841.7513635659182;1887.4240009592;8361.372897032732;8584.141585841428;8851.778705532364;9395;9428.198603118735;8801.427907186044;9076.455412675228;9085.682001129946;9190.540472976358;9207.309451791109;2151.397608669575;2413.553492603865;2453.877306134695;2454.6563481112657;2461.1386014894824;2412.9155479558217;2427.2354208424376;2466.136852101768;2466.90132394704;2475.7276699563035;2415.9852861798086;2438.51229754049;2445.877706114696;2467.2968204061845;2470.197185914576;2399.928002159938;2428.138011006094;2441.182203961666;2443.0472115874823;2445.119756887519;2407.8916448759846;2430.5138972205455;2431.513697260555;2438.171021852561;2442.6702395176603;9109.316801239867;9200.26397888174;9262.953685231598;9264.44413335202;9296.442213467213;5078.61910356721;5455.454454554552;5608.887822243532;5623.8594035149445;5634.098544232944;3532.452469867175;3551.5915669698056;3645.708343332527;3675.779453232788;3683.0424089736593;1067.9786404271872;1083.2254937719567;1109.112709832131;1110.9111271098293;1125.4654039331333;10098.091171794575;10359;12108.515659373614;12113.697157571043;12117.878821211763;4163.646090082317;4373.518912919576;4702.764861756898;4851.757412129379;4976.42771081323;8964.193222609865;10211.183105351554;10371.533281002374;10412;10420.47897605132;5457.508824205841;5537.335519737658;5538.224648549206;5558.972205139029;5561.332640083216;4556.840510582114;4728.692634978715;4913.557779799835;5034.597232221414;5058.924116138261;4092.856750013735;4115.444415003996;4243.851465198703;4250.53244143144;4280.507741609693;1322.8544860065385;1326.1711430356027;1339.852616212216;1343.751405989895;1352.1616597709287;745.1803016681715;809.0412860760018;853.547619761515;856.246503077288;894;6016.278046634432;6116.235470566179;6120.846978825565;6206.100115483229;6232.345603711636;929.2658799548416;946.4463288976026;967.3953778888194;983.8278301297245;988.19462138357;3722.7952462614276;3726.7391282609956;3998.520177578709;4043.211573743092;4092.0997380576227;10615.186975451512;10854.72863178411;11120.721981950515;11199.160062995308;11307.547698092148;9991.550380232908;10981.780364392667;11076.058535024613;11185.217034807485;11215.943920280346;8318.500889946623;8359.916400835913;8448.957755211184;8482.703105391158;8579.871301930476;5948.226730525004;5982.611130276518;6051.878962420815;6136.048912418582;6158.938410616016;10045.829878299923;10307.433091179757;10314.123299519624;10330.948345258226;10489.213309001703;10279.845802312822;10430.73923151897;10635.670541182351;10639.680809575726;10657;6677.699503522256;6826.453883689393;6991.720331186695;7258.818529536804;7324.304191101837;8589.055203927437;8764.430312029697;8865.601047952729;8882.378233523592;8882.422642528216;6923;7778.688852445839;7804.804879878048;7904.6838126474295;8031.116577176623;6600.867982640416;7628.732994345171;7639.159692433939;7690.961545192238;7699.88450173259;7184.425245980414;7283.417326613752;7326.633668316456;7343.192248852729;7343.596102214429;4998.900021999612;5093.490650934877;5097.235414687826;5164.431912489698;5244.239585260039;5100.719281117382;5179.067767801681;5336.973315133399;5413.079776437936;5435.945640543544 08:12:34 INFO - PROCESS | 2435 | |4;prototype.html;294.13670875978994;315.5172585943507;319.295952424903;319.95200719892;320.5048200530181;4586.449626044875;5015.517318927136;5090.592752579794;5357.8392648220515;5482.684155802609;4678.485366609671;5682.829515114553;5693.089105743082;5693.487586117249;5739.253896993396;4096.508418989711;4182.372644103393;4242.066745316026;4243.342281946288;4314.935275970863;3835.5205599299948;3954.9321683145536;4315.503717072545;4322.7406355618605;4361.214981303364;4268.317069268917;4298.570142985708;4314.956850431487;4329.285667864799;4335.070893452415;3339.6159441664277;3992.800359982018;4073.4704488416614;4255.34041723728;4317.244482215616;3078.8614512347;3664.59689434162;3664.6885014773775;3676.7793932363875;3681.263747250534;4987.276844857475;5595.356533998561;5616.5787565932715;5617.556362982075;5635.280714728259;4695.004623035196;4826.444958829745;4922.474033049766;4960.429550601655;4973.701577905337;5234.659747116425;5823.737931793037;5964.7315870785915;6060.878692457649;6071.81414690711;3381.3406385754542;3762.7554208976603;4032.3749818778138;4047.0691740899465;4075.1661752211326;5873.826684126858;5949.732262048218;6374.641382688388;6393.2328120625825;6418.2132541800565;3798.753081049723;3815.599362066943;4124.484439445069;4129.669626429938;4167.916341751166;3797.981010094987;3929.31237033518;4202.760185745151;4212.073343864345;4213.419967512183;4194.224068547267;4599.586037256663;4888.5111488850835;4922.556969872729;4979.659560006791;5790.407637899527;5891.587588868823;6094.841980023782;6118.571699980958;6202.4417802398;1405.599404169827;1425.8431572527013;1426.4650755966513;1430.2419717549715;1433.6630891740433;752.8381397999457;854.4019186569302;862.9084208476282;873.5850471026212;878.0517041595062;4907.895723462192;5111.795528178905;5639.182318563785;5665.405132461032;5687.744051517691;5103;5570.749316280777;5664.745086471036;6094.756209751649;6306.810795676137;4437.778111094497;4737;4884.95115048852;4891.3124971884645;5410.864728381822;3134.890278840275;3249.5125731140047;3250.464637582689;3279.2621660126756;3283.619375952463;6084.265984194483;6454;6461.353864613501;6519.445847102955;6527.445167160845;5684.971575142098;6130.908036379458;6337.33457986914;6429.935700643027;6435.935640643627;5613.691246981455;6346.397092276226;6463.8060858173385;6492.772752953813;6510.339863334914;5141.38303403594;5238.345206849144;5615;5664.3377612522045;6233.345498722569;5074.985002999489;5145.382554093533;6143.938560614337;6199.070139479114;6208.192934918432;6072.635641861502;6410.967945160244;6445;6447.451966582706;6447.45454454599;3397;3622.69207117398;4045.8583949561626;4059.837606495707;4078.306687863011;5328.8401347959625;5331.333583302087;5720.914186287126;6057.7879774207695;6146.0166373381835;4884.951150488591;5693.4875861172695;5862.706864656665;6083.631182983793;6118.694065296629;5513.566472717042;5986.760529578943;6062.757489700362;6086.969565152146;6105.603135796337;5087.720175390389;5202.869928251824;5536.335639723098;5893.5874488785375;5997.520198384032;5361.892762144813;5752.769889204553;5987.161797348288;6035.758569657164;6116.755329786936;5936;5960.523158147251;5982;5993.430624090704;6020.839059493625 08:12:34 INFO - PROCESS | 2435 | |5;yui.html;664.2261765043725;672.2370109925234;697.1251079894731;739.9038125043744;792.2988155482396;16220.270087846045;16236.675266494678;16896.746548801777;17070.82929170708;17077.91461042693;13285.53859075501;14939.850601493981;15190.924045379785;15405.460808871692;15423.383064677428;706.7526365771964;727.2291371146601;795.6697970342301;846.991530084699;874.8294082653885;704.4857254204434;855.3841234311317;864.6411739128254;865.5628907401754;871.8866547348836;884.4295429448002;908.0783005249676;908.9454632722025;910.5902343945252;912.5710915869531;901.5717534171282;903.9593218305192;905.4612505559181;906.3021473465427;908.1055160666738;648.9156409666713;666.1007639686433;677.6577828196729;679.0459404536634;684.3567046975827;14481.78277325841;14783.926080369636;14865.777013344808;15197.544073677807;15202.46791362308;15199.240037998055;15215.163166025864;15243.314050867737;15265.007774494623;15307.46423875159;10123.544440500194;10336.018078282552;11782.469788859436;11930.22453540517;12519.43662535188;3193;3970.990369753895;4002.959970400317;4014.879553613396;4027.4160246764054;105296;107870.46064769627;108324.91675083306;126201.36899315537;126345;11003.449827508593;11534.961853433231;11594.188406811441;11691.123165762601;11878.990285825801;20000.6999545032;22064.558708825734;23023.424414389774;23028.65457018146;23131.306060818202;7874.291313781787;7916.802079948047;8050.194980501903;8305.95847020761;8373.874391884126;4631.768411579407;4665.953340466552;4667.7199368037345;4674.5325467452985;4752.738599377068;3661.615530369273;3765.3410653135593;3810.0665336992615;3835.7698538087247;3851.5763266040713;708.6315116139579;741.3476140995889;741.929516695913;743.8507505903392;754.9773506794805;572.556268891604;654.1953397321226;656.4977791989132;693.3136195166749;707.2927072927073;9874.703758887244;10170.288079834341;10185.541650625739;10226.28416010887;10400.739981500523;583.5185971573469;637.3085202555279;687.3092541995263;705.3228900255812;706.9293070692889;4079.7801507224212;4712.670113092051;4839.927401088987;4903.828366007244;4920.3111564381015;170014;171082;174424;176542;177691.11154444402;142412;144973;146375.53624463832;150776;152265;122659;124093;128420;128483.99999999814;128908.71091288967;8966.551672416483;9091.818163636823;9334.25325973934;9338.813223735351;9390.248780097712;64287.357126428135;66131;66467.66766166332;68474.31525684679;71231.93152102827;77372.61313693396;84816.57591712002;88136;104706.47646761718;109629.90370096196;12967.416466258852;13512.459501619825;14057.226852522801;14059.22674252926;14386.496472623408;15194.01238919511;16521.256543455813;16563.923344982537;16734.748978765572;16784.832151678325;14743.926280368529;14788.852111478747;15165.01427407215;15322.387104515694;15722.449714259947;14813.185274809988;14841;15277.77083343773;15366.154861482726;15409.229538523254;12830.230186188859;14615.342309596306;14933.328000240233;15061.77407338869;15239.847601523843;9153.679621213225;9642.469664168539;11339.206255562362;11898.286102833858;12078.818817717916;9643.517824108627;11738.295702257892;12000.63998080059;12232;12272 08:12:34 INFO - PROCESS | 2435 | __end_tp_report 08:12:34 INFO - PROCESS | 2435 | __start_cc_report 08:12:34 INFO - PROCESS | 2435 | _x_x_mozilla_cycle_collect,346 08:12:34 INFO - PROCESS | 2435 | __end_cc_report 08:12:34 INFO - PROCESS | 2435 | __startTimestamp1482163954403__endTimestamp 08:12:34 INFO - PROCESS | 2435 | 08:12:34 INFO - PROCESS | 2435 | ------- Summary: start ------- 08:12:34 INFO - PROCESS | 2435 | Number of tests: 6 08:12:34 INFO - PROCESS | 2435 | 08:12:34 INFO - PROCESS | 2435 | [#0] dojo.html Cycles:165 Average:5954.79 Median:6214.04 stddev:680.64 (11.0%) stddev-sans-first:656.12 08:12:34 INFO - PROCESS | 2435 | Values: 3552.3 3559.9 3578.0 3584.1 3611.3 6024.4 6122.3 6140.9 6155.9 6161.8 6089.0 6118.2 6164.4 6205.7 6210.8 5452.9 5503.2 5527.5 5568.0 5608.9 5567.0 5582.0 5588.8 5594.1 5601.0 5445.2 5454.0 5549.3 5563.8 5579.5 4704.4 5309.2 5483.4 5495.2 5518.2 5348.5 5445.3 5496.5 5511.6 5525.9 4765.9 5972.1 6009.3 6103.7 6189.4 6400.0 6411.4 6417.8 6420.4 6437.5 6503.9 6522.9 6547.8 6549.0 6556.5 6085.3 6109.9 6115.5 6145.7 6235.9 6644.6 6656.9 6682.0 6682.3 6686.9 6302.3 6304.1 6304.4 6309.5 6319.1 5933.6 6212.3 6317.9 6354.2 6488.2 6217.7 6304.9 6370.6 6385.2 6388.0 6342.7 6350.4 6351.5 6360.3 6366.5 4282.2 5146.9 5166.3 5196.5 5238.8 4630.9 4633.7 4672.5 4708.9 4748.6 6156.1 6213.4 6228.6 6246.3 6255.4 6301.1 6335.5 6355.3 6502.5 6529.2 5192.5 5410.4 6152.6 6190.1 6215.4 4335.3 5372.9 5799.4 5807.1 5809.0 6505.4 6545.1 6693.5 6743.1 6754.4 5489.9 5617.7 6320.9 6370.0 6517.9 6650.1 6723.2 6730.6 6734.5 6749.5 6214.0 6355.7 6399.4 6416.4 6424.7 4938.9 6258.2 6321.0 6364.2 6513.4 6303.1 6338.3 6339.1 6346.3 6349.8 5889.3 6278.9 6315.1 6333.2 6345.7 6067.5 6107.2 6117.3 6186.8 6195.5 6270.9 6301.5 6319.6 6332.1 6352.6 4923.6 6216.9 6221.4 6231.1 6233.8 08:12:34 INFO - PROCESS | 2435 | 08:12:34 INFO - PROCESS | 2435 | [#1] ext.html Cycles:180 Average:82103.03 Median:18596.32 stddev:207359.63 (1115.1%) stddev-sans-first:207850.81 08:12:34 INFO - PROCESS | 2435 | Values: 500.4 510.1 519.5 536.2 559.1 40575.4 41841.0 42011.0 44998.1 45027.8 36797.8 44237.3 44477.9 44607.0 44828.6 10125.6 10187.4 10313.8 10327.1 10329.2 10127.9 10151.2 10231.9 10241.7 10253.0 10220.4 10228.9 10260.0 10264.1 10273.9 10068.0 10172.4 10218.1 10233.1 10242.3 10082.1 10171.0 10179.9 10181.3 10208.3 40423.4 42102.6 42195.6 42514.4 42539.6 3294.3 3560.9 3714.8 3750.6 4073.8 29684.9 30089.4 30415.4 30485.7 32285.0 3355.4 3375.8 3387.9 3402.7 3447.9 492530.5 497641.0 498721.0 499133.0 501967.0 34286.3 34448.0 49242.5 59426.7 59978.4 35695.5 36050.8 36139.0 36169.0 36266.1 15510.5 15731.4 15744.5 15752.0 15758.6 13143.1 13300.7 13337.3 13341.5 13368.7 8033.5 8039.8 8050.0 8093.5 8124.9 3304.6 3351.6 3369.9 3377.8 3417.6 876.4 946.6 982.8 1064.9 1153.3 25275.6 29586.0 30314.2 30712.2 31262.4 990.4 1027.7 1114.2 1144.8 1156.8 15101.8 15484.0 15558.0 15841.0 15865.0 1018657.0 1038974.0 1045543.0 1045729.0 1050523.0 55149.4 56484.0 56693.4 56931.7 56953.7 1355.6 1370.3 1383.3 1416.7 1424.6 25512.2 28927.0 29674.0 30318.5 30783.5 48907.0 49262.3 49284.3 49405.5 49484.5 645563.0 651827.0 652887.0 654370.0 655638.0 22482.0 27101.6 27229.5 27274.7 27475.3 44207.3 44449.6 44869.0 45092.5 45472.0 33602.2 35805.7 36365.8 37218.4 38668.8 37238.8 37371.0 37465.8 37752.6 37924.4 33814.8 34808.8 36823.8 38374.2 39955.8 29197.4 32788.0 34482.1 34859.5 35141.8 25800.5 26232.0 26424.4 26789.7 26827.5 08:12:34 INFO - PROCESS | 2435 | 08:12:34 INFO - PROCESS | 2435 | [#2] jquery.html Cycles:180 Average:39000.64 Median:29893.63 stddev:108049.21 (361.4%) stddev-sans-first:108313.37 08:12:34 INFO - PROCESS | 2435 | Values: 362.4 384.8 395.2 399.4 413.9 20405.9 21943.3 22034.6 22214.6 22354.7 20977.5 20992.3 22534.9 23507.3 23516.3 6228.0 7375.8 7377.3 7393.7 7443.7 6939.1 7083.8 7085.3 7090.3 7294.2 6351.9 6587.0 6741.8 6773.5 7052.0 7076.5 7119.3 7160.7 7283.4 7296.1 6753.3 6932.2 6933.5 6962.8 7027.3 29414.6 29828.4 29958.9 30081.2 30098.0 2491.9 2497.2 2670.3 2833.6 2920.9 17574.9 17603.6 17686.9 18125.9 18191.5 2009.7 2090.9 2146.8 2184.4 2257.0 97257.5 141188.3 150185.2 150414.0 153665.0 19531.7 21404.4 22174.9 22891.5 23054.5 30444.1 37415.6 37593.0 38225.0 38266.2 11445.5 11490.2 11672.7 11808.5 12008.3 9734.2 9760.7 9770.2 9886.2 9925.3 10195.1 10405.9 10427.2 10497.9 10627.9 3975.5 4047.7 4063.8 4064.0 4130.0 775.9 816.7 831.9 866.5 902.9 21466.8 21906.7 22322.0 22477.6 22621.9 911.4 960.3 974.1 975.3 1051.3 11534.6 11628.5 11694.3 11767.6 11848.3 635936.0 642096.0 645446.0 658430.0 661762.0 93167.5 129206.0 134938.0 136815.3 137229.0 942.4 976.6 980.1 1025.2 1041.7 19444.4 19685.8 19918.0 19966.4 20131.1 43800.0 55750.7 56701.0 58195.7 58877.7 64910.7 81976.2 82029.6 84796.6 86258.0 8150.6 8319.3 8343.4 8455.2 8488.4 10742.6 12252.9 12987.4 13090.2 13131.9 11004.2 11114.8 11285.1 11556.1 11693.4 10153.7 10379.9 10651.5 10981.4 11271.9 8877.2 10261.8 11501.7 11612.2 11992.7 8041.3 8198.8 8322.7 8404.5 8433.3 9369.2 11410.9 11442.7 11623.5 11686.2 08:12:34 INFO - PROCESS | 2435 | 08:12:34 INFO - PROCESS | 2435 | [#3] mootools.html Cycles:180 Average:5860.80 Median:4987.66 stddev:3271.92 (65.6%) stddev-sans-first:3264.83 08:12:34 INFO - PROCESS | 2435 | Values: 1520.0 1538.6 1761.3 1841.8 1887.4 8361.4 8584.1 8851.8 9395.0 9428.2 8801.4 9076.5 9085.7 9190.5 9207.3 2151.4 2413.6 2453.9 2454.7 2461.1 2412.9 2427.2 2466.1 2466.9 2475.7 2416.0 2438.5 2445.9 2467.3 2470.2 2399.9 2428.1 2441.2 2443.0 2445.1 2407.9 2430.5 2431.5 2438.2 2442.7 9109.3 9200.3 9263.0 9264.4 9296.4 5078.6 5455.5 5608.9 5623.9 5634.1 3532.5 3551.6 3645.7 3675.8 3683.0 1068.0 1083.2 1109.1 1110.9 1125.5 10098.1 10359.0 12108.5 12113.7 12117.9 4163.6 4373.5 4702.8 4851.8 4976.4 8964.2 10211.2 10371.5 10412.0 10420.5 5457.5 5537.3 5538.2 5559.0 5561.3 4556.8 4728.7 4913.6 5034.6 5058.9 4092.9 4115.4 4243.9 4250.5 4280.5 1322.9 1326.2 1339.9 1343.8 1352.2 745.2 809.0 853.5 856.2 894.0 6016.3 6116.2 6120.8 6206.1 6232.3 929.3 946.4 967.4 983.8 988.2 3722.8 3726.7 3998.5 4043.2 4092.1 10615.2 10854.7 11120.7 11199.2 11307.5 9991.6 10981.8 11076.1 11185.2 11215.9 8318.5 8359.9 8449.0 8482.7 8579.9 5948.2 5982.6 6051.9 6136.0 6158.9 10045.8 10307.4 10314.1 10330.9 10489.2 10279.8 10430.7 10635.7 10639.7 10657.0 6677.7 6826.5 6991.7 7258.8 7324.3 8589.1 8764.4 8865.6 8882.4 8882.4 6923.0 7778.7 7804.8 7904.7 8031.1 6600.9 7628.7 7639.2 7691.0 7699.9 7184.4 7283.4 7326.6 7343.2 7343.6 4998.9 5093.5 5097.2 5164.4 5244.2 5100.7 5179.1 5337.0 5413.1 5435.9 08:12:34 INFO - PROCESS | 2435 | 08:12:34 INFO - PROCESS | 2435 | [#4] prototype.html Cycles:180 Average:4804.48 Median:5330.09 stddev:1514.33 (28.4%) stddev-sans-first:1480.25 08:12:34 INFO - PROCESS | 2435 | Values: 294.1 315.5 319.3 320.0 320.5 4586.4 5015.5 5090.6 5357.8 5482.7 4678.5 5682.8 5693.1 5693.5 5739.3 4096.5 4182.4 4242.1 4243.3 4314.9 3835.5 3954.9 4315.5 4322.7 4361.2 4268.3 4298.6 4315.0 4329.3 4335.1 3339.6 3992.8 4073.5 4255.3 4317.2 3078.9 3664.6 3664.7 3676.8 3681.3 4987.3 5595.4 5616.6 5617.6 5635.3 4695.0 4826.4 4922.5 4960.4 4973.7 5234.7 5823.7 5964.7 6060.9 6071.8 3381.3 3762.8 4032.4 4047.1 4075.2 5873.8 5949.7 6374.6 6393.2 6418.2 3798.8 3815.6 4124.5 4129.7 4167.9 3798.0 3929.3 4202.8 4212.1 4213.4 4194.2 4599.6 4888.5 4922.6 4979.7 5790.4 5891.6 6094.8 6118.6 6202.4 1405.6 1425.8 1426.5 1430.2 1433.7 752.8 854.4 862.9 873.6 878.1 4907.9 5111.8 5639.2 5665.4 5687.7 5103.0 5570.7 5664.7 6094.8 6306.8 4437.8 4737.0 4885.0 4891.3 5410.9 3134.9 3249.5 3250.5 3279.3 3283.6 6084.3 6454.0 6461.4 6519.4 6527.4 5685.0 6130.9 6337.3 6429.9 6435.9 5613.7 6346.4 6463.8 6492.8 6510.3 5141.4 5238.3 5615.0 5664.3 6233.3 5075.0 5145.4 6143.9 6199.1 6208.2 6072.6 6411.0 6445.0 6447.5 6447.5 3397.0 3622.7 4045.9 4059.8 4078.3 5328.8 5331.3 5720.9 6057.8 6146.0 4885.0 5693.5 5862.7 6083.6 6118.7 5513.6 5986.8 6062.8 6087.0 6105.6 5087.7 5202.9 5536.3 5893.6 5997.5 5361.9 5752.8 5987.2 6035.8 6116.8 5936.0 5960.5 5982.0 5993.4 6020.8 08:12:34 INFO - PROCESS | 2435 | 08:12:34 INFO - PROCESS | 2435 | [#5] yui.html Cycles:180 Average:27179.65 Median:23026.04 stddev:44670.47 (194.0%) stddev-sans-first:44751.42 08:12:34 INFO - PROCESS | 2435 | Values: 664.2 672.2 697.1 739.9 792.3 16220.3 16236.7 16896.7 17070.8 17077.9 13285.5 14939.9 15190.9 15405.5 15423.4 706.8 727.2 795.7 847.0 874.8 704.5 855.4 864.6 865.6 871.9 884.4 908.1 908.9 910.6 912.6 901.6 904.0 905.5 906.3 908.1 648.9 666.1 677.7 679.0 684.4 14481.8 14783.9 14865.8 15197.5 15202.5 15199.2 15215.2 15243.3 15265.0 15307.5 10123.5 10336.0 11782.5 11930.2 12519.4 3193.0 3971.0 4003.0 4014.9 4027.4 105296.0 107870.5 108324.9 126201.4 126345.0 11003.4 11535.0 11594.2 11691.1 11879.0 20000.7 22064.6 23023.4 23028.7 23131.3 7874.3 7916.8 8050.2 8306.0 8373.9 4631.8 4666.0 4667.7 4674.5 4752.7 3661.6 3765.3 3810.1 3835.8 3851.6 708.6 741.3 741.9 743.9 755.0 572.6 654.2 656.5 693.3 707.3 9874.7 10170.3 10185.5 10226.3 10400.7 583.5 637.3 687.3 705.3 706.9 4079.8 4712.7 4839.9 4903.8 4920.3 170014.0 171082.0 174424.0 176542.0 177691.1 142412.0 144973.0 146375.5 150776.0 152265.0 122659.0 124093.0 128420.0 128484.0 128908.7 8966.6 9091.8 9334.3 9338.8 9390.2 64287.4 66131.0 66467.7 68474.3 71231.9 77372.6 84816.6 88136.0 104706.5 109629.9 12967.4 13512.5 14057.2 14059.2 14386.5 15194.0 16521.3 16563.9 16734.7 16784.8 14743.9 14788.9 15165.0 15322.4 15722.4 14813.2 14841.0 15277.8 15366.2 15409.2 12830.2 14615.3 14933.3 15061.8 15239.8 9153.7 9642.5 11339.2 11898.3 12078.8 9643.5 11738.3 12000.6 12232.0 12272.0 08:12:34 INFO - PROCESS | 2435 | -------- Summary: end -------- 08:12:34 INFO - PROCESS | 2435 | 08:12:34 INFO - TEST-INFO | 2435: exit 0 08:12:34 INFO - TEST-OK | dromaeo_css | took 1112970ms 08:12:34 INFO - TEST-START | kraken 08:12:34 INFO - operating with platform_type : mac_ 08:12:34 INFO - Initialising browser for kraken test... 08:12:34 INFO - TEST-INFO | started process 2439 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpyKP1kz/profile http://localhost:60353/getInfo.html) 08:12:37 INFO - PROCESS | 2439 | __metrics Screen width/height:1600/1200 08:12:37 INFO - PROCESS | 2439 | colorDepth:24 08:12:37 INFO - PROCESS | 2439 | Browser inner width/height: 1024/689 08:12:37 INFO - PROCESS | 2439 | __metrics 08:12:37 ERROR - PROCESS | 2439 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 08:12:37 INFO - TEST-INFO | 2439: exit 0 08:12:37 INFO - Browser initialized. 08:12:37 INFO - Running cycle 1/1 for kraken test... 08:12:37 INFO - TEST-INFO | started process 2442 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpyKP1kz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:49 INFO - PROCESS | 2442 | RSS: Main: 175038464 08:12:49 INFO - PROCESS | 2442 | 08:12:52 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:60353/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60353/tests/kraken/driver.html?testName=audio-beat-detection) 08:12:53 INFO - PROCESS | 2442 | RSS: Main: 187035648 08:12:53 INFO - PROCESS | 2442 | 08:12:56 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:60353/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60353/tests/kraken/driver.html?testName=audio-dft) 08:12:56 INFO - PROCESS | 2442 | RSS: Main: 194560000 08:12:56 INFO - PROCESS | 2442 | 08:13:00 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:60353/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60353/tests/kraken/driver.html?testName=audio-fft) 08:13:00 INFO - PROCESS | 2442 | RSS: Main: 198283264 08:13:00 INFO - PROCESS | 2442 | 08:13:02 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:60353/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60353/tests/kraken/driver.html?testName=audio-oscillator) 08:13:03 INFO - PROCESS | 2442 | RSS: Main: 198729728 08:13:03 INFO - PROCESS | 2442 | 08:13:05 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:60353/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60353/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:13:05 INFO - PROCESS | 2442 | RSS: Main: 199987200 08:13:05 INFO - PROCESS | 2442 | 08:13:08 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:60353/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60353/tests/kraken/driver.html?testName=imaging-darkroom) 08:13:09 INFO - PROCESS | 2442 | RSS: Main: 200445952 08:13:09 INFO - PROCESS | 2442 | 08:13:12 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:60353/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60353/tests/kraken/driver.html?testName=imaging-desaturate) 08:13:12 INFO - PROCESS | 2442 | RSS: Main: 200200192 08:13:12 INFO - PROCESS | 2442 | 08:13:15 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:60353/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60353/tests/kraken/driver.html?testName=json-parse-financial) 08:13:16 INFO - PROCESS | 2442 | RSS: Main: 200794112 08:13:16 INFO - PROCESS | 2442 | 08:13:17 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:60353/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60353/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:13:18 INFO - PROCESS | 2442 | RSS: Main: 200630272 08:13:18 INFO - PROCESS | 2442 | 08:13:20 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:60353/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60353/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:13:21 INFO - PROCESS | 2442 | RSS: Main: 200732672 08:13:21 INFO - PROCESS | 2442 | 08:13:23 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:60353/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60353/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:13:24 INFO - PROCESS | 2442 | RSS: Main: 200450048 08:13:24 INFO - PROCESS | 2442 | 08:13:26 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:60353/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60353/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:13:27 INFO - PROCESS | 2442 | RSS: Main: 200511488 08:13:27 INFO - PROCESS | 2442 | 08:13:30 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:60353/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60353/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:13:31 INFO - PROCESS | 2442 | RSS: Main: 201121792 08:13:31 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:60353/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60353/tests/kraken/driver.html?testName=ai-astar) 08:13:33 INFO - PROCESS | 2442 | RSS: Main: 202432512 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | __start_tp_report 08:13:33 INFO - PROCESS | 2442 | _x_x_mozilla_page_load 08:13:33 INFO - PROCESS | 2442 | _x_x_mozilla_page_load_details 08:13:33 INFO - PROCESS | 2442 | |i|pagename|runs| 08:13:33 INFO - PROCESS | 2442 | |0;ai-astar;106;117;116;117;118;127;165;164;118;117 08:13:33 INFO - PROCESS | 2442 | |1;audio-beat-detection;141;113;109;142;114;142;113;112;139;144 08:13:33 INFO - PROCESS | 2442 | |2;audio-dft;196;202;202;205;199;198;203;199;203;201 08:13:33 INFO - PROCESS | 2442 | |3;audio-fft;86;59;58;84;57;59;59;59;74;58 08:13:33 INFO - PROCESS | 2442 | |4;audio-oscillator;96;68;90;82;55;66;96;94;98;112 08:13:33 INFO - PROCESS | 2442 | |5;imaging-gaussian-blur;91;87;109;76;132;129;133;87;93;88 08:13:33 INFO - PROCESS | 2442 | |6;imaging-darkroom;147;122;96;96;96;100;101;95;95;100 08:13:33 INFO - PROCESS | 2442 | |7;imaging-desaturate;94;97;94;96;105;94;94;139;86;140 08:13:33 INFO - PROCESS | 2442 | |8;json-parse-financial;56;54;55;54;58;59;57;59;57;59 08:13:33 INFO - PROCESS | 2442 | |9;json-stringify-tinderbox;63;106;96;100;74;72;67;69;67;68 08:13:33 INFO - PROCESS | 2442 | |10;stanford-crypto-aes;84;80;100;100;103;85;86;66;71;94 08:13:33 INFO - PROCESS | 2442 | |11;stanford-crypto-ccm;141;150;150;157;152;150;153;158;194;141 08:13:33 INFO - PROCESS | 2442 | |12;stanford-crypto-pbkdf2;162;166;164;162;194;220;145;221;217;213 08:13:33 INFO - PROCESS | 2442 | |13;stanford-crypto-sha256-iterative;67;67;67;68;68;69;77;84;85;87 08:13:33 INFO - PROCESS | 2442 | __end_tp_report 08:13:33 INFO - PROCESS | 2442 | __start_cc_report 08:13:33 INFO - PROCESS | 2442 | _x_x_mozilla_cycle_collect,901 08:13:33 INFO - PROCESS | 2442 | __end_cc_report 08:13:33 INFO - PROCESS | 2442 | __startTimestamp1482164013445__endTimestamp 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | ------- Summary: start ------- 08:13:33 INFO - PROCESS | 2442 | Number of tests: 14 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | [#0] ai-astar Cycles:10 Average:126.50 Median:118.00 stddev:20.64 (17.5%) stddev-sans-first:20.52 08:13:33 INFO - PROCESS | 2442 | Values: 106.0 117.0 116.0 117.0 118.0 127.0 165.0 164.0 118.0 117.0 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:140.00 stddev:15.60 (11.1%) stddev-sans-first:15.68 08:13:33 INFO - PROCESS | 2442 | Values: 141.0 113.0 109.0 142.0 114.0 142.0 113.0 112.0 139.0 144.0 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | [#2] audio-dft Cycles:10 Average:200.80 Median:202.00 stddev:2.74 (1.4%) stddev-sans-first:2.29 08:13:33 INFO - PROCESS | 2442 | Values: 196.0 202.0 202.0 205.0 199.0 198.0 203.0 199.0 203.0 201.0 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | [#3] audio-fft Cycles:10 Average:65.30 Median:59.00 stddev:11.49 (19.5%) stddev-sans-first:9.43 08:13:33 INFO - PROCESS | 2442 | Values: 86.0 59.0 58.0 84.0 57.0 59.0 59.0 59.0 74.0 58.0 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | [#4] audio-oscillator Cycles:10 Average:85.70 Median:92.00 stddev:17.64 (19.2%) stddev-sans-first:18.31 08:13:33 INFO - PROCESS | 2442 | Values: 96.0 68.0 90.0 82.0 55.0 66.0 96.0 94.0 98.0 112.0 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | [#5] imaging-gaussian-blur Cycles:10 Average:102.50 Median:87.00 stddev:21.50 (24.7%) stddev-sans-first:22.40 08:13:33 INFO - PROCESS | 2442 | Values: 91.0 87.0 109.0 76.0 132.0 129.0 133.0 87.0 93.0 88.0 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | [#6] imaging-darkroom Cycles:10 Average:104.80 Median:95.00 stddev:16.87 (17.8%) stddev-sans-first:8.54 08:13:33 INFO - PROCESS | 2442 | Values: 147.0 122.0 96.0 96.0 96.0 100.0 101.0 95.0 95.0 100.0 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | [#7] imaging-desaturate Cycles:10 Average:103.90 Median:94.00 stddev:19.32 (20.6%) stddev-sans-first:20.16 08:13:33 INFO - PROCESS | 2442 | Values: 94.0 97.0 94.0 96.0 105.0 94.0 94.0 139.0 86.0 140.0 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.50 stddev:1.99 (3.5%) stddev-sans-first:2.09 08:13:33 INFO - PROCESS | 2442 | Values: 56.0 54.0 55.0 54.0 58.0 59.0 57.0 59.0 57.0 59.0 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | [#9] json-stringify-tinderbox Cycles:10 Average:78.20 Median:68.50 stddev:15.96 (23.3%) stddev-sans-first:15.95 08:13:33 INFO - PROCESS | 2442 | Values: 63.0 106.0 96.0 100.0 74.0 72.0 67.0 69.0 67.0 68.0 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:82.00 stddev:12.49 (15.2%) stddev-sans-first:13.20 08:13:33 INFO - PROCESS | 2442 | Values: 84.0 80.0 100.0 100.0 103.0 85.0 86.0 66.0 71.0 94.0 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | [#11] stanford-crypto-ccm Cycles:10 Average:154.60 Median:152.50 stddev:14.95 (9.8%) stddev-sans-first:15.03 08:13:33 INFO - PROCESS | 2442 | Values: 141.0 150.0 150.0 157.0 152.0 150.0 153.0 158.0 194.0 141.0 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:203.50 stddev:29.53 (14.5%) stddev-sans-first:29.98 08:13:33 INFO - PROCESS | 2442 | Values: 162.0 166.0 164.0 162.0 194.0 220.0 145.0 221.0 217.0 213.0 08:13:33 INFO - PROCESS | 2442 | 08:13:33 INFO - PROCESS | 2442 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:73.00 stddev:8.45 (11.6%) stddev-sans-first:8.59 08:13:33 INFO - PROCESS | 2442 | Values: 67.0 67.0 67.0 68.0 68.0 69.0 77.0 84.0 85.0 87.0 08:13:33 INFO - PROCESS | 2442 | -------- Summary: end -------- 08:13:33 INFO - PROCESS | 2442 | 08:13:34 INFO - TEST-INFO | 2442: exit 0 08:13:34 INFO - TEST-OK | kraken | took 59471ms 08:13:34 INFO - SUITE-END | took 1172s 08:13:34 INFO - Completed test suite (00:19:32) 08:13:34 INFO - javascript benchmark 08:13:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7738.860978595624, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3552.3428165789314, 3559.893203203904, 3578.0, 3584.139806446454, 3611.295797319524, 6024.397560243973, 6122.295935967365, 6140.907886381702, 6155.9076613850775, 6161.753529858812, 6088.969555152229, 6118.174046503721, 6164.445199932005, 6205.720742566584, 6210.813675589739, 5452.863678408042, 5503.174523821439, 5527.474889885474, 5568.0, 5608.859778505529, 5567.0, 5581.995240856644, 5588.804391846286, 5594.13290939905, 5601.0, 5445.1832225166345, 5454.0, 5549.306336707911, 5563.805266815662, 5579.497845193931, 4704.435467743892, 5309.203619457093, 5483.369412517552, 5495.175723641446, 5518.227448157221, 5348.465153484621, 5445.264889239941, 5496.4503549645115, 5511.614187006911, 5525.917111243334, 4765.904681906377, 5972.134040564138, 6009.278886533601, 6103.664298463583, 6189.442950134509, 6400.007998760199, 6411.3909178627955, 6417.775377861799, 6420.390062944013, 6437.485001199892, 6503.93496065038, 6522.869542609169, 6547.803565893031, 6549.0, 6556.475481961432, 6085.300190478108, 6109.920916985209, 6115.483736156547, 6145.692715364214, 6235.87528249437, 6644.60132392058, 6656.900146497806, 6681.966590167018, 6682.264950855402, 6686.866262674719, 6302.338254483213, 6304.085907543381, 6304.432601065834, 6309.463695585927, 6319.0837328587095, 5933.554983376264, 6212.316645169028, 6317.936820631735, 6354.237491500957, 6488.221413430324, 6217.720202590895, 6304.873902522016, 6370.617762934239, 6385.233771947396, 6388.041793730978, 6342.746290148435, 6350.428461438492, 6351.460125889351, 6360.332165122595, 6366.458850997625, 4282.207791558571, 5146.87132821675, 5166.328377310925, 5196.53231209193, 5238.764255608507, 4630.907381852344, 4633.698809577367, 4672.486026537078, 4708.882277943078, 4748.572628463386, 6156.07658851167, 6213.440790328892, 6228.5951413158, 6246.281677607042, 6255.374462553708, 6301.149344838388, 6335.524835637346, 6355.30091689923, 6502.479801615859, 6529.216494020748, 5192.480751924777, 5410.431904650034, 6152.630842149485, 6190.0714892765545, 6215.378462153749, 4335.328024156261, 5372.91940620891, 5799.449052340021, 5807.0998995155815, 5808.983427900101, 6505.447037001908, 6545.083688283549, 6693.531452798355, 6743.055972163901, 6754.425873800684, 5489.890202196014, 5617.74720137603, 6320.873582528232, 6369.9681501592195, 6517.902231466626, 6650.068990341259, 6723.226828914541, 6730.562513436611, 6734.528582999339, 6749.493787965824, 6214.036824292242, 6355.682215889095, 6399.424051835357, 6416.422521973045, 6424.743010279536, 4938.901221975469, 6258.249010118815, 6321.0, 6364.204474440695, 6513.381228783258, 6303.05454181858, 6338.334474880071, 6339.112524246517, 6346.301906790157, 6349.841253968688, 5889.293284805851, 6278.905816412849, 6315.084312774714, 6333.240011198685, 6345.650989195638, 6067.453929146398, 6107.249501910372, 6117.279373342116, 6186.845328866814, 6195.473384762166, 6270.905936410866, 6301.495880329654, 6319.557630965788, 6332.0818481320875, 6352.555321127662, 4923.5814955729165, 6216.875662486635, 6221.377862213742, 6231.096491008869, 6233.75064997395], "value": 5914.942127677545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.3745318352062, 510.1098582972711, 519.5272302204993, 536.1769683535772, 559.1165957786698, 40575.39136912945, 41841.0, 42011.0, 44998.10003799922, 45027.77486112565, 36797.816010919974, 44237.336439953426, 44477.8880527987, 44607.0, 44828.55171448285, 10125.645602403918, 10187.439690817002, 10313.84529232062, 10327.12219461343, 10329.225308101884, 10127.898721012805, 10151.23865710071, 10231.897681023207, 10241.692749217535, 10253.025962533547, 10220.386776793417, 10228.948855255714, 10260.0, 10264.127549158331, 10273.897261027369, 10068.0, 10172.44051577163, 10218.131458826008, 10233.130183934412, 10242.28304018719, 10082.143017843493, 10171.0, 10179.949100254451, 10181.28730988831, 10208.336458130198, 40423.393649095284, 42102.57897421017, 42195.578044219474, 42514.36228456576, 42539.574604253874, 3294.3246634439884, 3560.893173204782, 3714.814259287025, 3750.5686846012786, 4073.796310184479, 29684.8515757422, 30089.398212035638, 30415.39169216603, 30485.695143048506, 32285.0, 3355.4295769719206, 3375.8143302118374, 3387.8814241501427, 3402.727781777452, 3447.9310413791836, 492530.53734731453, 497641.0, 498721.0, 499132.9999999964, 501967.0, 34286.314273714386, 34448.0, 49242.50757492451, 59426.70286648626, 59978.400215998154, 35695.4645680315, 36050.81974590163, 36139.0, 36169.0, 36266.09334766599, 15510.457134000257, 15731.44939927097, 15744.527664169864, 15752.0, 15758.606034848992, 13143.079984401, 13300.73398532024, 13337.333133343489, 13341.533046343526, 13368.6657833553, 8033.517988920684, 8039.758807235792, 8050.0, 8093.473924194908, 8124.918750812534, 3304.603447586305, 3351.631320554737, 3369.8652053917567, 3377.8142202178624, 3417.5898892133105, 876.3909083187251, 946.5929650250458, 982.8181786369545, 1064.856244406995, 1153.2561497834017, 25275.62086568703, 29585.964491242703, 30314.242143946576, 30712.232194195323, 31262.374752504824, 990.4156547636785, 1027.701966429742, 1114.169943392178, 1144.841972881125, 1156.8438260834848, 15101.848981510264, 15484.0, 15558.0, 15841.0, 15865.04809711421, 1018657.0, 1038974.0, 1045543.0, 1045729.0, 1050523.0, 55149.44850551523, 56484.0, 56693.43306566964, 56931.71534142303, 56953.71523142441, 1355.600097971101, 1370.287450525721, 1383.3429121167364, 1416.732024837785, 1424.622475044114, 25512.23463296104, 28927.0, 29674.0, 30318.545221822133, 30783.53824692676, 48907.02185956332, 49262.26106608332, 49284.2607360897, 49405.50594494009, 49484.50515494943, 645563.0, 651827.0, 652887.0, 654370.0, 655638.0, 22481.98831052574, 27101.59347609748, 27229.455410892067, 27274.727252727218, 27475.31311717223, 44207.33688994732, 44449.55550444584, 44869.0, 45092.54907450883, 45472.0, 33602.15994600154, 35805.74679886192, 36365.81817090898, 37218.44172337363, 38668.80665596654, 37238.8138059308, 37371.0, 37465.81267093647, 37752.62247377491, 37924.43113353357, 33814.830925845214, 34808.82595587006, 36823.815880920425, 38374.23251535009, 39955.800220999874, 29197.416051679273, 32788.0, 34482.137946551535, 34859.47710784391, 35141.82429087838, 25800.483990320463, 26232.0, 26424.412066078217, 26789.732102678725, 26827.463450730487], "value": 19225.214570094373, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.4418395670667, 384.8422146919763, 395.1898607853899, 399.38295333709414, 413.8510136350913, 20405.897970510145, 21943.341699749013, 22034.559308813856, 22214.55570888581, 22354.66468002981, 20977.475563110893, 20992.320614350854, 22534.887325563348, 23507.294781156594, 23516.29451116465, 6227.968860155693, 7375.815604609874, 7377.336039756421, 7393.667284972189, 7443.739469118582, 6939.0979172707475, 7083.822904427405, 7085.291470852925, 7090.29097090292, 7294.197638259787, 6351.936480635204, 6587.011948207759, 6741.831454213635, 6773.458123350145, 7052.04797352356, 7076.469264805134, 7119.252478489736, 7160.677769500333, 7283.417326613885, 7296.0515133032895, 6753.29090445506, 6932.202796678396, 6933.514653974224, 6962.756303529352, 7027.332403421718, 29414.558781618292, 29828.403431931456, 29958.85020574905, 30081.247968800737, 30098.0, 2491.875406229681, 2497.21337778601, 2670.34300870635, 2833.5749637554327, 2920.9123726288035, 17574.912125439292, 17603.647927041515, 17686.91156544222, 18125.909370453195, 18191.4542563722, 2009.6635737234722, 2090.874547527153, 2146.8389870759756, 2184.432047667618, 2256.988715056414, 97257.51371243098, 141188.29405852905, 150185.24907375392, 150414.0, 153665.0, 19531.730437521517, 21404.36125858608, 22174.889125554593, 22891.542169156855, 23054.538909222058, 30444.086677399715, 37415.62584374121, 37593.0, 38225.0, 38266.23467530689, 11445.54217831294, 11490.161574148096, 11672.70818229551, 11808.46861891217, 12008.339541325311, 9734.172595329335, 9760.658376956773, 9770.218382529381, 9886.209103271722, 9925.255605829592, 10195.082442580204, 10405.895941040493, 10427.170203516556, 10497.895021049844, 10627.946860265649, 3975.5458515283844, 4047.6964227683043, 4063.837446502107, 4063.959360406417, 4129.958700413017, 775.8564665536894, 816.6896579299947, 831.9376046796393, 866.5234121233296, 902.9413088149381, 21466.78533214648, 21906.671399929015, 22321.995510201756, 22477.55044899093, 22621.886890565773, 911.3984770051734, 960.2605993385055, 974.0843607009389, 975.3221511049752, 1051.321897376188, 11534.59628912984, 11628.452852426828, 11694.298342099331, 11767.646970590897, 11848.348340841336, 635936.0, 642096.0, 645446.0, 658430.0, 661762.0, 93167.5341623301, 129206.0, 134938.0, 136815.31592341975, 137229.0, 942.3780304998668, 976.6191185437685, 980.1423754215061, 1025.190099821148, 1041.739565108723, 19444.416667499998, 19685.80314196897, 19918.0, 19966.401007969784, 20131.094100765207, 43800.0, 55750.72124639351, 56701.0, 58195.70902145462, 58877.70561147167, 64910.67544662247, 81976.18023819686, 82029.58985205035, 84796.57601711951, 86258.0, 8150.592470376576, 8319.334453243848, 8343.374246931384, 8455.239028487465, 8488.448250863674, 10742.624008159677, 12252.938735306267, 12987.41556629935, 13090.214587124803, 13131.934340328236, 11004.229703920648, 11114.833277500682, 11285.097192224439, 11556.133290003452, 11693.356865372487, 10153.746156346151, 10379.896201037893, 10651.520681569504, 10981.3960232188, 11271.887281127412, 8877.245434137913, 10261.846072308772, 11501.712457188303, 11612.187146899636, 11992.700182495508, 8041.276285134366, 8198.795030124294, 8322.6670933162, 8404.537750423786, 8433.325333973145, 9369.203617692572, 11410.885891140982, 11442.656720298404, 11623.476943537393, 11686.18196726255], "value": 11362.022303411119, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.9620009499765, 1538.5845821628157, 1761.321891071937, 1841.7513635659182, 1887.4240009592, 8361.372897032732, 8584.141585841428, 8851.778705532364, 9395.0, 9428.198603118735, 8801.427907186044, 9076.455412675228, 9085.682001129946, 9190.540472976358, 9207.309451791109, 2151.397608669575, 2413.553492603865, 2453.877306134695, 2454.6563481112657, 2461.1386014894824, 2412.9155479558217, 2427.2354208424376, 2466.136852101768, 2466.90132394704, 2475.7276699563035, 2415.9852861798086, 2438.51229754049, 2445.877706114696, 2467.2968204061845, 2470.197185914576, 2399.928002159938, 2428.138011006094, 2441.182203961666, 2443.0472115874823, 2445.119756887519, 2407.8916448759846, 2430.5138972205455, 2431.513697260555, 2438.171021852561, 2442.6702395176603, 9109.316801239867, 9200.26397888174, 9262.953685231598, 9264.44413335202, 9296.442213467213, 5078.61910356721, 5455.454454554552, 5608.887822243532, 5623.8594035149445, 5634.098544232944, 3532.452469867175, 3551.5915669698056, 3645.708343332527, 3675.779453232788, 3683.0424089736593, 1067.9786404271872, 1083.2254937719567, 1109.112709832131, 1110.9111271098293, 1125.4654039331333, 10098.091171794575, 10359.0, 12108.515659373614, 12113.697157571043, 12117.878821211763, 4163.646090082317, 4373.518912919576, 4702.764861756898, 4851.757412129379, 4976.42771081323, 8964.193222609865, 10211.183105351554, 10371.533281002374, 10412.0, 10420.47897605132, 5457.508824205841, 5537.335519737658, 5538.224648549206, 5558.972205139029, 5561.332640083216, 4556.840510582114, 4728.692634978715, 4913.557779799835, 5034.597232221414, 5058.924116138261, 4092.856750013735, 4115.444415003996, 4243.851465198703, 4250.53244143144, 4280.507741609693, 1322.8544860065385, 1326.1711430356027, 1339.852616212216, 1343.751405989895, 1352.1616597709287, 745.1803016681715, 809.0412860760018, 853.547619761515, 856.246503077288, 894.0, 6016.278046634432, 6116.235470566179, 6120.846978825565, 6206.100115483229, 6232.345603711636, 929.2658799548416, 946.4463288976026, 967.3953778888194, 983.8278301297245, 988.19462138357, 3722.7952462614276, 3726.7391282609956, 3998.520177578709, 4043.211573743092, 4092.0997380576227, 10615.186975451512, 10854.72863178411, 11120.721981950515, 11199.160062995308, 11307.547698092148, 9991.550380232908, 10981.780364392667, 11076.058535024613, 11185.217034807485, 11215.943920280346, 8318.500889946623, 8359.916400835913, 8448.957755211184, 8482.703105391158, 8579.871301930476, 5948.226730525004, 5982.611130276518, 6051.878962420815, 6136.048912418582, 6158.938410616016, 10045.829878299923, 10307.433091179757, 10314.123299519624, 10330.948345258226, 10489.213309001703, 10279.845802312822, 10430.73923151897, 10635.670541182351, 10639.680809575726, 10657.0, 6677.699503522256, 6826.453883689393, 6991.720331186695, 7258.818529536804, 7324.304191101837, 8589.055203927437, 8764.430312029697, 8865.601047952729, 8882.378233523592, 8882.422642528216, 6923.0, 7778.688852445839, 7804.804879878048, 7904.6838126474295, 8031.116577176623, 6600.867982640416, 7628.732994345171, 7639.159692433939, 7690.961545192238, 7699.88450173259, 7184.425245980414, 7283.417326613752, 7326.633668316456, 7343.192248852729, 7343.596102214429, 4998.900021999612, 5093.490650934877, 5097.235414687826, 5164.431912489698, 5244.239585260039, 5100.719281117382, 5179.067767801681, 5336.973315133399, 5413.079776437936, 5435.945640543544], "value": 4709.119785457445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.13670875978994, 315.5172585943507, 319.295952424903, 319.95200719892, 320.5048200530181, 4586.449626044875, 5015.517318927136, 5090.592752579794, 5357.8392648220515, 5482.684155802609, 4678.485366609671, 5682.829515114553, 5693.089105743082, 5693.487586117249, 5739.253896993396, 4096.508418989711, 4182.372644103393, 4242.066745316026, 4243.342281946288, 4314.935275970863, 3835.5205599299948, 3954.9321683145536, 4315.503717072545, 4322.7406355618605, 4361.214981303364, 4268.317069268917, 4298.570142985708, 4314.956850431487, 4329.285667864799, 4335.070893452415, 3339.6159441664277, 3992.800359982018, 4073.4704488416614, 4255.34041723728, 4317.244482215616, 3078.8614512347, 3664.59689434162, 3664.6885014773775, 3676.7793932363875, 3681.263747250534, 4987.276844857475, 5595.356533998561, 5616.5787565932715, 5617.556362982075, 5635.280714728259, 4695.004623035196, 4826.444958829745, 4922.474033049766, 4960.429550601655, 4973.701577905337, 5234.659747116425, 5823.737931793037, 5964.7315870785915, 6060.878692457649, 6071.81414690711, 3381.3406385754542, 3762.7554208976603, 4032.3749818778138, 4047.0691740899465, 4075.1661752211326, 5873.826684126858, 5949.732262048218, 6374.641382688388, 6393.2328120625825, 6418.2132541800565, 3798.753081049723, 3815.599362066943, 4124.484439445069, 4129.669626429938, 4167.916341751166, 3797.981010094987, 3929.31237033518, 4202.760185745151, 4212.073343864345, 4213.419967512183, 4194.224068547267, 4599.586037256663, 4888.5111488850835, 4922.556969872729, 4979.659560006791, 5790.407637899527, 5891.587588868823, 6094.841980023782, 6118.571699980958, 6202.4417802398, 1405.599404169827, 1425.8431572527013, 1426.4650755966513, 1430.2419717549715, 1433.6630891740433, 752.8381397999457, 854.4019186569302, 862.9084208476282, 873.5850471026212, 878.0517041595062, 4907.895723462192, 5111.795528178905, 5639.182318563785, 5665.405132461032, 5687.744051517691, 5103.0, 5570.749316280777, 5664.745086471036, 6094.756209751649, 6306.810795676137, 4437.778111094497, 4737.0, 4884.95115048852, 4891.3124971884645, 5410.864728381822, 3134.890278840275, 3249.5125731140047, 3250.464637582689, 3279.2621660126756, 3283.619375952463, 6084.265984194483, 6454.0, 6461.353864613501, 6519.445847102955, 6527.445167160845, 5684.971575142098, 6130.908036379458, 6337.33457986914, 6429.935700643027, 6435.935640643627, 5613.691246981455, 6346.397092276226, 6463.8060858173385, 6492.772752953813, 6510.339863334914, 5141.38303403594, 5238.345206849144, 5615.0, 5664.3377612522045, 6233.345498722569, 5074.985002999489, 5145.382554093533, 6143.938560614337, 6199.070139479114, 6208.192934918432, 6072.635641861502, 6410.967945160244, 6445.0, 6447.451966582706, 6447.45454454599, 3397.0, 3622.69207117398, 4045.8583949561626, 4059.837606495707, 4078.306687863011, 5328.8401347959625, 5331.333583302087, 5720.914186287126, 6057.7879774207695, 6146.0166373381835, 4884.951150488591, 5693.4875861172695, 5862.706864656665, 6083.631182983793, 6118.694065296629, 5513.566472717042, 5986.760529578943, 6062.757489700362, 6086.969565152146, 6105.603135796337, 5087.720175390389, 5202.869928251824, 5536.335639723098, 5893.5874488785375, 5997.520198384032, 5361.892762144813, 5752.769889204553, 5987.161797348288, 6035.758569657164, 6116.755329786936, 5936.0, 5960.523158147251, 5982.0, 5993.430624090704, 6020.839059493625], "value": 4313.96848492375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.2261765043725, 672.2370109925234, 697.1251079894731, 739.9038125043744, 792.2988155482396, 16220.270087846045, 16236.675266494678, 16896.746548801777, 17070.82929170708, 17077.91461042693, 13285.53859075501, 14939.850601493981, 15190.924045379785, 15405.460808871692, 15423.383064677428, 706.7526365771964, 727.2291371146601, 795.6697970342301, 846.991530084699, 874.8294082653885, 704.4857254204434, 855.3841234311317, 864.6411739128254, 865.5628907401754, 871.8866547348836, 884.4295429448002, 908.0783005249676, 908.9454632722025, 910.5902343945252, 912.5710915869531, 901.5717534171282, 903.9593218305192, 905.4612505559181, 906.3021473465427, 908.1055160666738, 648.9156409666713, 666.1007639686433, 677.6577828196729, 679.0459404536634, 684.3567046975827, 14481.78277325841, 14783.926080369636, 14865.777013344808, 15197.544073677807, 15202.46791362308, 15199.240037998055, 15215.163166025864, 15243.314050867737, 15265.007774494623, 15307.46423875159, 10123.544440500194, 10336.018078282552, 11782.469788859436, 11930.22453540517, 12519.43662535188, 3193.0, 3970.990369753895, 4002.959970400317, 4014.879553613396, 4027.4160246764054, 105296.0, 107870.46064769627, 108324.91675083306, 126201.36899315537, 126345.0, 11003.449827508593, 11534.961853433231, 11594.188406811441, 11691.123165762601, 11878.990285825801, 20000.6999545032, 22064.558708825734, 23023.424414389774, 23028.65457018146, 23131.306060818202, 7874.291313781787, 7916.802079948047, 8050.194980501903, 8305.95847020761, 8373.874391884126, 4631.768411579407, 4665.953340466552, 4667.7199368037345, 4674.5325467452985, 4752.738599377068, 3661.615530369273, 3765.3410653135593, 3810.0665336992615, 3835.7698538087247, 3851.5763266040713, 708.6315116139579, 741.3476140995889, 741.929516695913, 743.8507505903392, 754.9773506794805, 572.556268891604, 654.1953397321226, 656.4977791989132, 693.3136195166749, 707.2927072927073, 9874.703758887244, 10170.288079834341, 10185.541650625739, 10226.28416010887, 10400.739981500523, 583.5185971573469, 637.3085202555279, 687.3092541995263, 705.3228900255812, 706.9293070692889, 4079.7801507224212, 4712.670113092051, 4839.927401088987, 4903.828366007244, 4920.3111564381015, 170014.0, 171082.0, 174424.0, 176542.0, 177691.11154444402, 142412.0, 144973.0, 146375.53624463832, 150776.0, 152265.0, 122659.0, 124093.0, 128420.0, 128483.99999999814, 128908.71091288967, 8966.551672416483, 9091.818163636823, 9334.25325973934, 9338.813223735351, 9390.248780097712, 64287.357126428135, 66131.0, 66467.66766166332, 68474.31525684679, 71231.93152102827, 77372.61313693396, 84816.57591712002, 88136.0, 104706.47646761718, 109629.90370096196, 12967.416466258852, 13512.459501619825, 14057.226852522801, 14059.22674252926, 14386.496472623408, 15194.01238919511, 16521.256543455813, 16563.923344982537, 16734.748978765572, 16784.832151678325, 14743.926280368529, 14788.852111478747, 15165.01427407215, 15322.387104515694, 15722.449714259947, 14813.185274809988, 14841.0, 15277.77083343773, 15366.154861482726, 15409.229538523254, 12830.230186188859, 14615.342309596306, 14933.328000240233, 15061.77407338869, 15239.847601523843, 9153.679621213225, 9642.469664168539, 11339.206255562362, 11898.286102833858, 12078.818817717916, 9643.517824108627, 11738.295702257892, 12000.63998080059, 12232.0, 12272.0], "value": 8183.229879534855, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 116.0, 117.0, 118.0, 127.0, 165.0, 164.0, 118.0, 117.0], "value": 126.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 113.0, 109.0, 142.0, 114.0, 142.0, 113.0, 112.0, 139.0, 144.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 202.0, 202.0, 205.0, 199.0, 198.0, 203.0, 199.0, 203.0, 201.0], "value": 200.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 59.0, 58.0, 84.0, 57.0, 59.0, 59.0, 59.0, 74.0, 58.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 68.0, 90.0, 82.0, 55.0, 66.0, 96.0, 94.0, 98.0, 112.0], "value": 85.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 109.0, 76.0, 132.0, 129.0, 133.0, 87.0, 93.0, 88.0], "value": 102.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 96.0, 96.0, 96.0, 100.0, 101.0, 95.0, 95.0, 100.0], "value": 104.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 94.0, 96.0, 105.0, 94.0, 94.0, 139.0, 86.0, 140.0], "value": 103.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 54.0, 58.0, 59.0, 57.0, 59.0, 57.0, 59.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 106.0, 96.0, 100.0, 74.0, 72.0, 67.0, 69.0, 67.0, 68.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 100.0, 100.0, 103.0, 85.0, 86.0, 66.0, 71.0, 94.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 150.0, 150.0, 157.0, 152.0, 150.0, 153.0, 158.0, 194.0, 141.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 164.0, 162.0, 194.0, 220.0, 145.0, 221.0, 217.0, 213.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 68.0, 68.0, 69.0, 77.0, 84.0, 85.0, 87.0], "value": 73.9, "unit": "score"}]}]} 08:13:34 INFO - Return code: 0 08:13:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:13:34 ERROR - # TBPL SUCCESS # 08:13:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:13:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:13:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:13:34 INFO - 2016-12-19 08:13:34.731 screenresolution[2447:131544] starting screenresolution argv=screenresolution get 08:13:34 INFO - 2016-12-19 08:13:34.736 screenresolution[2447:131544] Display 0: 1600x1200x32@60 08:13:34 INFO - 2016-12-19 08:13:34.742 screenresolution[2448:131547] starting screenresolution argv=screenresolution list 08:13:34 INFO - Available Modes on Display 0 08:13:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:13:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:13:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:13:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:13:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:13:34 INFO - Intel Iris: 08:13:34 INFO - Chipset Model: Intel Iris 08:13:34 INFO - Type: GPU 08:13:34 INFO - Bus: Built-In 08:13:34 INFO - VRAM (Dynamic, Max): 1536 MB 08:13:34 INFO - Vendor: Intel (0x8086) 08:13:34 INFO - Device ID: 0x0a2e 08:13:34 INFO - Revision ID: 0x0009 08:13:34 INFO - Displays: 08:13:34 INFO - Display: 08:13:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:13:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:13:34 INFO - Display Serial Number: 1600x1200 60 08:13:34 INFO - Main Display: Yes 08:13:34 INFO - Mirror: Off 08:13:34 INFO - Online: Yes 08:13:34 INFO - Rotation: Supported 08:13:34 INFO - Return code: 0 08:13:34 INFO - Running post-action listener: _resource_record_post_action 08:13:34 INFO - [mozharness: 2016-12-19 16:13:34.985588Z] Finished run-tests step (success) 08:13:34 INFO - Running post-run listener: _resource_record_post_run 08:13:35 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 937984; Write bytes: 496931840; Read time: 6; Write time: 1683 08:13:35 INFO - TinderboxPrint: CPU usage
54.3% 08:13:35 INFO - TinderboxPrint: I/O read bytes / time
937,984 / 6 08:13:35 INFO - TinderboxPrint: I/O write bytes / time
496,931,840 / 1,683 08:13:35 INFO - TinderboxPrint: CPU idle
2,183.0 (45.7%) 08:13:35 INFO - TinderboxPrint: CPU system
974.2 (20.4%) 08:13:35 INFO - TinderboxPrint: CPU user
1,624.5 (34.0%) 08:13:35 INFO - TinderboxPrint: Swap in / out
195,399,680 / 0 08:13:35 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 190102016; Write bytes: 188950016; Read time: 17778; Write time: 411 08:13:35 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 102400; Write bytes: 296959488; Read time: 2; Write time: 1240 08:13:35 INFO - Running post-run listener: _upload_blobber_files 08:13:35 INFO - Blob upload gear active. 08:13:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:13:35 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 08:13:35 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'] 08:13:35 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 08:13:35 INFO - (blobuploader) - INFO - Open directory for files ... 08:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:13:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:36 INFO - (blobuploader) - INFO - Done attempting. 08:13:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:13:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:13:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:37 INFO - (blobuploader) - INFO - Done attempting. 08:13:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:13:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:13:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:41 INFO - (blobuploader) - INFO - Done attempting. 08:13:41 INFO - (blobuploader) - INFO - Iteration through files over. 08:13:41 INFO - Return code: 0 08:13:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:13:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:13:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb91401f584c93f33ae75bb7987bdeddda2ecd70dde6db0e8f6b481fa163769b60059615516896ba816175dd143db8fe581d6f992a214e315f8854b3c9505707", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/762790675d5430e26802ae64c284cd6d5644edcf5dd0c22380b210c284a16b081cdf21fffb202fdaad3191e2ed3e2ed0c5461361bfaef4f10bad52adb64d9e41", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a00afc132672b7bc5f210a2c8cfccfee7d14efdc424a2fb9633f619254e250e80b285547c979015e7e3a3838eea1162455f9f4b7da504a79ed9d6e47eebdb090"} 08:13:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:13:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:13:41 INFO - Contents: 08:13:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb91401f584c93f33ae75bb7987bdeddda2ecd70dde6db0e8f6b481fa163769b60059615516896ba816175dd143db8fe581d6f992a214e315f8854b3c9505707", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/762790675d5430e26802ae64c284cd6d5644edcf5dd0c22380b210c284a16b081cdf21fffb202fdaad3191e2ed3e2ed0c5461361bfaef4f10bad52adb64d9e41", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a00afc132672b7bc5f210a2c8cfccfee7d14efdc424a2fb9633f619254e250e80b285547c979015e7e3a3838eea1162455f9f4b7da504a79ed9d6e47eebdb090"} 08:13:41 INFO - Running post-run listener: copy_logs_to_upload_dir 08:13:41 INFO - Copying logs to upload dir... 08:13:41 INFO - mkdir: /builds/slave/test/build/upload/logs 08:13:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.568637 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-12-19 08:13:41.523868) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 08:13:41.527916) ========= 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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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/cb91401f584c93f33ae75bb7987bdeddda2ecd70dde6db0e8f6b481fa163769b60059615516896ba816175dd143db8fe581d6f992a214e315f8854b3c9505707", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/762790675d5430e26802ae64c284cd6d5644edcf5dd0c22380b210c284a16b081cdf21fffb202fdaad3191e2ed3e2ed0c5461361bfaef4f10bad52adb64d9e41", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a00afc132672b7bc5f210a2c8cfccfee7d14efdc424a2fb9633f619254e250e80b285547c979015e7e3a3838eea1162455f9f4b7da504a79ed9d6e47eebdb090"} build_url:https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011497 build_url: 'https://queue.taskcluster.net/v1/task/FfdbuN3hTuWmcNzJ3C6Bew/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/cb91401f584c93f33ae75bb7987bdeddda2ecd70dde6db0e8f6b481fa163769b60059615516896ba816175dd143db8fe581d6f992a214e315f8854b3c9505707", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/762790675d5430e26802ae64c284cd6d5644edcf5dd0c22380b210c284a16b081cdf21fffb202fdaad3191e2ed3e2ed0c5461361bfaef4f10bad52adb64d9e41", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a00afc132672b7bc5f210a2c8cfccfee7d14efdc424a2fb9633f619254e250e80b285547c979015e7e3a3838eea1162455f9f4b7da504a79ed9d6e47eebdb090"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 08:13:41.561854) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 08:13:41.562206) ========= 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.jcpaSct6MN/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.2Z1gxzU4lJ/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.005617 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 08:13:41.610122) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 08:13:41.610445) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 08:13:41.610776) ========= ========= Total master_lag: 0.17 =========