builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0015 starttime: 1483450351.81 results: success (0) buildid: 20170103031119 builduid: 984dda339eb840ceb733246d98ff5319 revision: 0a17d39220700e742bf37a960967480b2f8159f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 05:32:31.813474) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 05:32:31.813990) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 05:32:31.814276) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 05:32:31.857784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 05:32:31.858041) ========= 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.I2durOYlWF/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.tq4NTUJgHm/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-03 05:32:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 204M=0s 2017-01-03 05:32:32 (204 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.597700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 05:32:32.480398) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 05:32:32.480712) ========= 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.I2durOYlWF/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.tq4NTUJgHm/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.026790 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 05:32:32.530747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-03 05:32:32.531210) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0a17d39220700e742bf37a960967480b2f8159f1 --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 0a17d39220700e742bf37a960967480b2f8159f1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.I2durOYlWF/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.tq4NTUJgHm/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-03 05:32:32,627 truncating revision to first 12 chars 2017-01-03 05:32:32,627 Setting DEBUG logging. 2017-01-03 05:32:32,627 attempt 1/10 2017-01-03 05:32:32,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0a17d3922070?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-03 05:32:33,398 unpacking tar archive at: mozilla-beta-0a17d3922070/testing/mozharness/ program finished with exit code 0 elapsedTime=1.064031 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-03 05:32:33.618803) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 05:32:33.619105) ========= script_repo_revision: 0a17d39220700e742bf37a960967480b2f8159f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 05:32:33.619520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 05:32:33.619787) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 05:32:33.639923) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-03 05:32:33.640272) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.I2durOYlWF/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.tq4NTUJgHm/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 05:32:33 INFO - MultiFileLogger online at 20170103 05:32:33 in /builds/slave/test 05:32:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:32:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:32:33 INFO - {'append_to_log': False, 05:32:33 INFO - 'base_work_dir': '/builds/slave/test', 05:32:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:32:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:32:33 INFO - 'branch': 'Mozilla-Beta', 05:32:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:33 INFO - 'config_files': ('talos/mac_config.py',), 05:32:33 INFO - 'default_actions': ('clobber', 05:32:33 INFO - 'read-buildbot-config', 05:32:33 INFO - 'download-and-extract', 05:32:33 INFO - 'populate-webroot', 05:32:33 INFO - 'create-virtualenv', 05:32:33 INFO - 'install', 05:32:33 INFO - 'run-tests'), 05:32:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:33 INFO - 'download_minidump_stackwalk': True, 05:32:33 INFO - 'download_symbols': 'ondemand', 05:32:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:32:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:32:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:32:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:32:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:33 INFO - 'installer_path': 'installer.exe', 05:32:33 INFO - 'log_level': 'info', 05:32:33 INFO - 'log_name': 'talos', 05:32:33 INFO - 'log_to_console': True, 05:32:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:32:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:32:33 INFO - 'opt_config_files': (), 05:32:33 INFO - 'pip_index': False, 05:32:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:32:33 INFO - 'cmd': ('bash', 05:32:33 INFO - '-c', 05:32:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:32:33 INFO - 'enabled': True, 05:32:33 INFO - 'halt_on_failure': False, 05:32:33 INFO - 'name': 'check_screen_resolution'},), 05:32:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:32:33 INFO - 'cmd': ('bash', 05:32:33 INFO - '-c', 05:32:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:32:33 INFO - 'enabled': True, 05:32:33 INFO - 'halt_on_failure': False, 05:32:33 INFO - 'name': 'check_screen_resolution'},), 05:32:33 INFO - 'run_cmd_checks_enabled': True, 05:32:33 INFO - 'sps_profile': False, 05:32:33 INFO - 'sps_profile_interval': 0, 05:32:33 INFO - 'suite': 'dromaeojs', 05:32:33 INFO - 'system_bits': '32', 05:32:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:33 INFO - 'title': 't-yosemite-r7-0015', 05:32:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:33 INFO - 'use_talos_json': True, 05:32:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:32:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:33 INFO - 'work_dir': 'build'} 05:32:33 INFO - [mozharness: 2017-01-03 13:32:33.852187Z] Running clobber step. 05:32:33 INFO - Running pre-action listener: _resource_record_pre_action 05:32:33 INFO - Running main action method: clobber 05:32:33 INFO - rmtree: /builds/slave/test/build 05:32:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:32:36 INFO - Running post-action listener: _resource_record_post_action 05:32:36 INFO - [mozharness: 2017-01-03 13:32:36.144110Z] Finished clobber step (success) 05:32:36 INFO - [mozharness: 2017-01-03 13:32:36.144230Z] Running read-buildbot-config step. 05:32:36 INFO - Running pre-action listener: _resource_record_pre_action 05:32:36 INFO - Running main action method: read_buildbot_config 05:32:36 INFO - Using buildbot properties: 05:32:36 INFO - { 05:32:36 INFO - "project": "", 05:32:36 INFO - "product": "firefox", 05:32:36 INFO - "script_repo_revision": "production", 05:32:36 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:32:36 INFO - "repository": "", 05:32:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:32:36 INFO - "buildid": "20170103031119", 05:32:36 INFO - "pgo_build": "False", 05:32:36 INFO - "basedir": "/builds/slave/test", 05:32:36 INFO - "buildnumber": 18, 05:32:36 INFO - "slavename": "t-yosemite-r7-0015", 05:32:36 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:32:36 INFO - "platform": "yosemite_r7", 05:32:36 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:32:36 INFO - "branch": "mozilla-beta", 05:32:36 INFO - "repo_path": "releases/mozilla-beta", 05:32:36 INFO - "revision": "0a17d39220700e742bf37a960967480b2f8159f1", 05:32:36 INFO - "stage_platform": "macosx64", 05:32:36 INFO - "builduid": "984dda339eb840ceb733246d98ff5319", 05:32:36 INFO - "slavebuilddir": "test" 05:32:36 INFO - } 05:32:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 05:32:36 INFO - Running post-action listener: _resource_record_post_action 05:32:36 INFO - [mozharness: 2017-01-03 13:32:36.147386Z] Finished read-buildbot-config step (success) 05:32:36 INFO - [mozharness: 2017-01-03 13:32:36.147525Z] Running download-and-extract step. 05:32:36 INFO - Running pre-action listener: _resource_record_pre_action 05:32:36 INFO - Running main action method: download_and_extract 05:32:36 INFO - mkdir: /builds/slave/test/build/tests 05:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:36 INFO - trying https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 05:32:36 INFO - Downloading https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/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 05:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/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 05:32:37 INFO - Downloaded 1165 bytes. 05:32:37 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 05:32:37 INFO - Using the following test package requirements: 05:32:37 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 05:32:37 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:32:37 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 05:32:37 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:32:37 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 05:32:37 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:32:37 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:32:37 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 05:32:37 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 05:32:37 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:32:37 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 05:32:37 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:32:37 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 05:32:37 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:32:37 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 05:32:37 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:32:37 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 05:32:37 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 05:32:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 05:32:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 05:32:37 INFO - Fetch https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 05:32:38 INFO - Expected file size: 16234662 05:32:44 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 05:32:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 05:32:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 05:32:44 INFO - Fetch https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 05:32:45 INFO - Expected file size: 16234662 05:32:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 05:32:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 05:32:52 INFO - Fetch https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 05:32:52 INFO - Expected file size: 14414089 05:32:53 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')]} 05:32:53 INFO - trying https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:32:53 INFO - Downloading https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 05:32:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/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 05:32:55 INFO - Downloaded 86087860 bytes. 05:32:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:32:55 INFO - mkdir: /builds/slave/test/properties 05:32:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:55 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:55 INFO - Contents: 05:32:55 INFO - build_url:https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:32:56 INFO - Running post-action listener: _resource_record_post_action 05:32:56 INFO - Running post-action listener: set_extra_try_arguments 05:32:56 INFO - [mozharness: 2017-01-03 13:32:56.354449Z] Finished download-and-extract step (success) 05:32:56 INFO - [mozharness: 2017-01-03 13:32:56.354564Z] Running populate-webroot step. 05:32:56 INFO - Running pre-action listener: _resource_record_pre_action 05:32:56 INFO - Running main action method: populate_webroot 05:32:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:56 INFO - '--tppagecycles', 05:32:56 INFO - '7'], 05:32:56 INFO - 'tests': ['tsvgm']}}, 05:32:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:32:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:32:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:56 INFO - 'talos_options': ['--disable-e10s'], 05:32:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:56 INFO - 'talos_options': ['--disable-e10s'], 05:32:56 INFO - 'tests': ['damp', 'tps']}, 05:32:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:56 INFO - 'tests': ['damp', 'tps']}, 05:32:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:32:56 INFO - 'tests': ['dromaeo_dom']}, 05:32:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:32:56 INFO - 'tests': ['basic_compositor_video']}, 05:32:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:32:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:32:56 INFO - 'tests': ['a11yr', 05:32:56 INFO - 'ts_paint', 05:32:56 INFO - 'tpaint', 05:32:56 INFO - 'sessionrestore', 05:32:56 INFO - 'sessionrestore_no_auto_restore', 05:32:56 INFO - 'tabpaint']}, 05:32:56 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:56 INFO - 'ts_paint', 05:32:56 INFO - 'tpaint', 05:32:56 INFO - 'sessionrestore', 05:32:56 INFO - 'sessionrestore_no_auto_restore', 05:32:56 INFO - 'tabpaint']}, 05:32:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:32:56 INFO - 'ts_paint', 05:32:56 INFO - 'tpaint', 05:32:56 INFO - 'sessionrestore', 05:32:56 INFO - 'sessionrestore_no_auto_restore', 05:32:56 INFO - 'tabpaint']}, 05:32:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:32:56 INFO - 'ts_paint', 05:32:56 INFO - 'tpaint', 05:32:56 INFO - 'sessionrestore', 05:32:56 INFO - 'sessionrestore_no_auto_restore', 05:32:56 INFO - 'tabpaint']}, 05:32:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:32:56 INFO - 'tests': ['a11yr', 05:32:56 INFO - 'ts_paint', 05:32:56 INFO - 'tpaint', 05:32:56 INFO - 'sessionrestore', 05:32:56 INFO - 'sessionrestore_no_auto_restore', 05:32:56 INFO - 'tabpaint']}, 05:32:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:32:56 INFO - 'tests': ['a11yr', 05:32:56 INFO - 'ts_paint', 05:32:56 INFO - 'tpaint', 05:32:56 INFO - 'sessionrestore', 05:32:56 INFO - 'sessionrestore_no_auto_restore', 05:32:56 INFO - 'tabpaint']}, 05:32:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:32:56 INFO - 'tests': ['tsvgx', 05:32:56 INFO - 'tsvgr_opacity', 05:32:56 INFO - 'tart', 05:32:56 INFO - 'tscrollx', 05:32:56 INFO - 'cart']}, 05:32:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:56 INFO - 'tsvgr_opacity', 05:32:56 INFO - 'tart', 05:32:56 INFO - 'tscrollx', 05:32:56 INFO - 'cart']}, 05:32:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:56 INFO - 'talos_options': ['--disable-e10s'], 05:32:56 INFO - 'tests': ['tp5o']}, 05:32:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:56 INFO - 'tests': ['tp5o']}, 05:32:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:56 INFO - 'talos_options': ['--disable-e10s', 05:32:56 INFO - '--xperf_path', 05:32:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:56 INFO - 'tests': ['tp5n']}, 05:32:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:56 INFO - 'talos_options': ['--xperf_path', 05:32:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:56 INFO - 'tests': ['tp5n']}}, 05:32:56 INFO - 'talos.zip': {'path': '', 05:32:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:56 INFO - Running post-action listener: _resource_record_post_action 05:32:56 INFO - [mozharness: 2017-01-03 13:32:56.373043Z] Finished populate-webroot step (success) 05:32:56 INFO - [mozharness: 2017-01-03 13:32:56.373161Z] Running create-virtualenv step. 05:32:56 INFO - Running pre-action listener: _resource_record_pre_action 05:32:56 INFO - Running main action method: create_virtualenv 05:32:56 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:56 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 05:32:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:56 INFO - Using real prefix '/tools/python27' 05:32:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:57 INFO - Installing distribute.............................................................................................................................................................................................done. 05:33:00 INFO - Installing pip.................done. 05:33:00 INFO - Return code: 0 05:33:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9785a1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b677d30>, '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 0x10b4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b66fb20>, '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.I2durOYlWF/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.tq4NTUJgHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 05:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I2durOYlWF/Render', 05:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:00 INFO - 'HOME': '/Users/cltbld', 05:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:00 INFO - 'LOGNAME': 'cltbld', 05:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:00 INFO - 'MOZ_NO_REMOTE': '1', 05:33:00 INFO - 'NO_EM_RESTART': '1', 05:33:00 INFO - 'PAGER': '/bin/cat', 05:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:00 INFO - 'PWD': '/builds/slave/test', 05:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:00 INFO - 'SHELL': '/bin/bash', 05:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tq4NTUJgHm/Listeners', 05:33:00 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 05:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:00 INFO - 'USER': 'cltbld', 05:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:00 INFO - 'XPC_FLAGS': '0x0', 05:33:00 INFO - 'XPC_SERVICE_NAME': '0', 05:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:00 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 05:33:00 INFO - Cleaning up... 05:33:00 INFO - Return code: 0 05:33:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9785a1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b677d30>, '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 0x10b4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b66fb20>, '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.I2durOYlWF/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.tq4NTUJgHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 05:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I2durOYlWF/Render', 05:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:00 INFO - 'HOME': '/Users/cltbld', 05:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:00 INFO - 'LOGNAME': 'cltbld', 05:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:00 INFO - 'MOZ_NO_REMOTE': '1', 05:33:00 INFO - 'NO_EM_RESTART': '1', 05:33:00 INFO - 'PAGER': '/bin/cat', 05:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:00 INFO - 'PWD': '/builds/slave/test', 05:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:00 INFO - 'SHELL': '/bin/bash', 05:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tq4NTUJgHm/Listeners', 05:33:00 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 05:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:00 INFO - 'USER': 'cltbld', 05:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:00 INFO - 'XPC_FLAGS': '0x0', 05:33:00 INFO - 'XPC_SERVICE_NAME': '0', 05:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:00 INFO - Downloading/unpacking psutil>=3.1.1 05:33:00 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 05:33:00 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 05:33:00 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 05:33:00 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 05:33:00 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 05:33:00 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 05:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:33:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:03 INFO - Installing collected packages: psutil 05:33:03 INFO - Running setup.py install for psutil 05:33:03 INFO - building 'psutil._psutil_osx' extension 05:33:03 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 05:33:04 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 05:33:04 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 05:33:04 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 05:33:04 INFO - building 'psutil._psutil_posix' extension 05:33:04 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 05:33:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:33:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:33:04 INFO - ^ 05:33:04 INFO - 1 warning generated. 05:33:04 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 05:33:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:04 INFO - Successfully installed psutil 05:33:04 INFO - Cleaning up... 05:33:04 INFO - Return code: 0 05:33:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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')]} 05:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:04 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 0x10b863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9785a1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b677d30>, '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 0x10b4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b66fb20>, '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.I2durOYlWF/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.tq4NTUJgHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 05:33:04 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 05:33:04 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 05:33:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I2durOYlWF/Render', 05:33:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:04 INFO - 'HOME': '/Users/cltbld', 05:33:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:04 INFO - 'LOGNAME': 'cltbld', 05:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:04 INFO - 'MOZ_NO_REMOTE': '1', 05:33:04 INFO - 'NO_EM_RESTART': '1', 05:33:04 INFO - 'PAGER': '/bin/cat', 05:33:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:04 INFO - 'PWD': '/builds/slave/test', 05:33:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:04 INFO - 'SHELL': '/bin/bash', 05:33:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tq4NTUJgHm/Listeners', 05:33:04 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 05:33:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:04 INFO - 'USER': 'cltbld', 05:33:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:04 INFO - 'XPC_FLAGS': '0x0', 05:33:04 INFO - 'XPC_SERVICE_NAME': '0', 05:33:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:33:05 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 05:33:05 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 05:33:05 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 05:33:05 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 05:33:05 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 05:33:05 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 05:33:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:33:07 INFO - Installing collected packages: mozsystemmonitor 05:33:07 INFO - Running setup.py install for mozsystemmonitor 05:33:08 INFO - Successfully installed mozsystemmonitor 05:33:08 INFO - Cleaning up... 05:33:08 INFO - Return code: 0 05:33:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:08 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 0x10b863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9785a1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b677d30>, '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 0x10b4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b66fb20>, '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.I2durOYlWF/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.tq4NTUJgHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 05:33:08 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 05:33:08 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 05:33:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I2durOYlWF/Render', 05:33:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:08 INFO - 'HOME': '/Users/cltbld', 05:33:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:08 INFO - 'LOGNAME': 'cltbld', 05:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:08 INFO - 'MOZ_NO_REMOTE': '1', 05:33:08 INFO - 'NO_EM_RESTART': '1', 05:33:08 INFO - 'PAGER': '/bin/cat', 05:33:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:08 INFO - 'PWD': '/builds/slave/test', 05:33:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:08 INFO - 'SHELL': '/bin/bash', 05:33:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tq4NTUJgHm/Listeners', 05:33:08 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 05:33:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:08 INFO - 'USER': 'cltbld', 05:33:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:08 INFO - 'XPC_FLAGS': '0x0', 05:33:08 INFO - 'XPC_SERVICE_NAME': '0', 05:33:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:08 INFO - Downloading/unpacking jsonschema==2.5.1 05:33:08 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 05:33:08 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 05:33:08 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 05:33:08 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 05:33:08 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 05:33:08 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 05:33:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:33:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:33:10 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 05:33:10 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 05:33:10 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 05:33:10 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 05:33:10 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 05:33:10 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 05:33:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:33:11 INFO - warning: no files found matching '*.txt' 05:33:11 INFO - no previously-included directories found matching 'build' 05:33:11 INFO - no previously-included directories found matching 'dist' 05:33:11 INFO - no previously-included directories found matching '.git*' 05:33:11 INFO - Installing collected packages: jsonschema, functools32 05:33:11 INFO - Running setup.py install for functools32 05:33:11 INFO - warning: no files found matching '*.txt' 05:33:11 INFO - no previously-included directories found matching 'build' 05:33:11 INFO - no previously-included directories found matching 'dist' 05:33:11 INFO - no previously-included directories found matching '.git*' 05:33:11 INFO - Successfully installed jsonschema functools32 05:33:11 INFO - Cleaning up... 05:33:11 INFO - Return code: 0 05:33:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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')]} 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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', '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 0x10b863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9785a1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b677d30>, '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 0x10b4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b66fb20>, '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.I2durOYlWF/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.tq4NTUJgHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 05:33: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:33: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 functools32==3.2.3-2 05:33:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I2durOYlWF/Render', 05:33:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:11 INFO - 'HOME': '/Users/cltbld', 05:33:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:11 INFO - 'LOGNAME': 'cltbld', 05:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:11 INFO - 'MOZ_NO_REMOTE': '1', 05:33:11 INFO - 'NO_EM_RESTART': '1', 05:33:11 INFO - 'PAGER': '/bin/cat', 05:33:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:11 INFO - 'PWD': '/builds/slave/test', 05:33:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:11 INFO - 'SHELL': '/bin/bash', 05:33:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tq4NTUJgHm/Listeners', 05:33:11 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 05:33:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:11 INFO - 'USER': 'cltbld', 05:33:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:11 INFO - 'XPC_FLAGS': '0x0', 05:33:11 INFO - 'XPC_SERVICE_NAME': '0', 05:33:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:33:11 INFO - Cleaning up... 05:33:11 INFO - Return code: 0 05:33:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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')]} 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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', '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 0x10b863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9785a1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b677d30>, '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 0x10b4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b66fb20>, '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.I2durOYlWF/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.tq4NTUJgHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 05:33: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:33: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 blobuploader==1.2.4 05:33:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I2durOYlWF/Render', 05:33:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:11 INFO - 'HOME': '/Users/cltbld', 05:33:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:11 INFO - 'LOGNAME': 'cltbld', 05:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:11 INFO - 'MOZ_NO_REMOTE': '1', 05:33:11 INFO - 'NO_EM_RESTART': '1', 05:33:11 INFO - 'PAGER': '/bin/cat', 05:33:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:11 INFO - 'PWD': '/builds/slave/test', 05:33:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:11 INFO - 'SHELL': '/bin/bash', 05:33:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tq4NTUJgHm/Listeners', 05:33:11 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 05:33:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:11 INFO - 'USER': 'cltbld', 05:33:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:11 INFO - 'XPC_FLAGS': '0x0', 05:33:11 INFO - 'XPC_SERVICE_NAME': '0', 05:33:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:33:12 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 05:33:12 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 05:33:12 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 05:33:12 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 05:33:12 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 05:33:12 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 05:33:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:33:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:33:14 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 05:33:14 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 05:33:14 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 05:33:14 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 05:33:14 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 05:33:14 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 05:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:33:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:33: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 05:33: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 05:33: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 05:33: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 05:33: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 05:33: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 05:33:16 INFO - Downloading docopt-0.6.1.tar.gz 05:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:33:16 INFO - Installing collected packages: blobuploader, requests, docopt 05:33:16 INFO - Running setup.py install for blobuploader 05:33:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:33:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:33:16 INFO - Running setup.py install for requests 05:33:16 INFO - Running setup.py install for docopt 05:33:16 INFO - Successfully installed blobuploader requests docopt 05:33:16 INFO - Cleaning up... 05:33:16 INFO - Return code: 0 05:33:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:16 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 0x10b863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9785a1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b677d30>, '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 0x10b4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b66fb20>, '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.I2durOYlWF/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.tq4NTUJgHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 05:33:16 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 05:33:16 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 05:33:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I2durOYlWF/Render', 05:33:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:16 INFO - 'HOME': '/Users/cltbld', 05:33:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:16 INFO - 'LOGNAME': 'cltbld', 05:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:16 INFO - 'MOZ_NO_REMOTE': '1', 05:33:16 INFO - 'NO_EM_RESTART': '1', 05:33:16 INFO - 'PAGER': '/bin/cat', 05:33:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:16 INFO - 'PWD': '/builds/slave/test', 05:33:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:16 INFO - 'SHELL': '/bin/bash', 05:33:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tq4NTUJgHm/Listeners', 05:33:16 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 05:33:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:16 INFO - 'USER': 'cltbld', 05:33:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:16 INFO - 'XPC_FLAGS': '0x0', 05:33:16 INFO - 'XPC_SERVICE_NAME': '0', 05:33:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:17 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-zdPMfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:17 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-_ane1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:17 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-cL7CSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:17 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-YUs8Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:17 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-j4KATq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:17 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-w11Pil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:17 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-qt9x52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:17 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-VMjl4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:18 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-HQ0n3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:18 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-T_Edya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:18 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-9CA_In-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:18 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-kLp1CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:18 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-TQ4IVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:18 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-1kq1Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:18 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-0o26Bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:18 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-3irkYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:18 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-Emdpht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:33:19 INFO - Running setup.py install for manifestparser 05:33:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozcrash 05:33:19 INFO - Running setup.py install for mozdebug 05:33:19 INFO - Running setup.py install for mozdevice 05:33:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozfile 05:33:19 INFO - Running setup.py install for mozhttpd 05:33:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozinfo 05:33:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Running setup.py install for mozInstall 05:33:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Running setup.py install for mozleak 05:33:20 INFO - Running setup.py install for mozlog 05:33:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Running setup.py install for moznetwork 05:33:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Running setup.py install for mozprocess 05:33:20 INFO - Running setup.py install for mozprofile 05:33:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Running setup.py install for mozrunner 05:33:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:33:21 INFO - Running setup.py install for mozscreenshot 05:33:21 INFO - Running setup.py install for moztest 05:33:21 INFO - Running setup.py install for mozversion 05:33:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:33:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:33:21 INFO - Cleaning up... 05:33:21 INFO - Return code: 0 05:33:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:21 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 0x10b863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9785a1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b677d30>, '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 0x10b4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b66fb20>, '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.I2durOYlWF/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.tq4NTUJgHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 05:33:21 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 05:33:21 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 05:33:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I2durOYlWF/Render', 05:33:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:21 INFO - 'HOME': '/Users/cltbld', 05:33:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:21 INFO - 'LOGNAME': 'cltbld', 05:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:21 INFO - 'MOZ_NO_REMOTE': '1', 05:33:21 INFO - 'NO_EM_RESTART': '1', 05:33:21 INFO - 'PAGER': '/bin/cat', 05:33:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:21 INFO - 'PWD': '/builds/slave/test', 05:33:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:21 INFO - 'SHELL': '/bin/bash', 05:33:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tq4NTUJgHm/Listeners', 05:33:21 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 05:33:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:21 INFO - 'USER': 'cltbld', 05:33:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:21 INFO - 'XPC_FLAGS': '0x0', 05:33:21 INFO - 'XPC_SERVICE_NAME': '0', 05:33:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:21 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-fObfyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:22 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-wwi3zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:22 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-gIuxKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:22 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-MRVk7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:22 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-qfqt9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:22 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-jH07F0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:22 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-rYSgKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:22 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-P8isic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:22 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-yiP5WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:22 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-mdTHjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:22 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-yYcS5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:23 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)) 05:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:23 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-t3mUpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:23 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)) 05:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:23 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-C04g1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:23 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)) 05:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:23 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-FPijiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:23 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)) 05:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:23 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-WV_7Np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:23 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)) 05:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:23 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-83FRfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:23 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)) 05:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:23 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-esjhMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:23 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)) 05:33:23 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)) 05:33:23 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)) 05:33:23 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)) 05:33:23 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)) 05:33:23 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)) 05:33:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:23 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 05:33:23 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 05:33:23 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 05:33:23 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 05:33:23 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 05:33:23 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 05:33:26 INFO - Downloading blessings-1.6.tar.gz 05:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:33:26 INFO - Installing collected packages: blessings 05:33:26 INFO - Running setup.py install for blessings 05:33:26 INFO - Successfully installed blessings 05:33:26 INFO - Cleaning up... 05:33:26 INFO - Return code: 0 05:33:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:26 INFO - Reading from file tmpfile_stdout 05:33:26 INFO - Current package versions: 05:33:26 INFO - blessings == 1.6 05:33:26 INFO - blobuploader == 1.2.4 05:33:26 INFO - docopt == 0.6.1 05:33:26 INFO - functools32 == 3.2.3-2 05:33:26 INFO - jsonschema == 2.5.1 05:33:26 INFO - manifestparser == 1.1 05:33:26 INFO - mozInstall == 1.12 05:33:26 INFO - mozcrash == 0.17 05:33:26 INFO - mozdebug == 0.1 05:33:26 INFO - mozdevice == 0.48 05:33:26 INFO - mozfile == 1.2 05:33:26 INFO - mozhttpd == 0.7 05:33:26 INFO - mozinfo == 0.9 05:33:26 INFO - mozleak == 0.1 05:33:26 INFO - mozlog == 3.4 05:33:26 INFO - moznetwork == 0.27 05:33:26 INFO - mozprocess == 0.23 05:33:26 INFO - mozprofile == 0.28 05:33:26 INFO - mozrunner == 6.12 05:33:26 INFO - mozscreenshot == 0.1 05:33:26 INFO - mozsystemmonitor == 0.3 05:33:26 INFO - moztest == 0.7 05:33:26 INFO - mozversion == 1.4 05:33:26 INFO - psutil == 3.1.1 05:33:26 INFO - requests == 1.2.3 05:33:26 INFO - wsgiref == 0.1.2 05:33:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:26 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')]} 05:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:26 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')]} 05:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:26 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 0x10b863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9785a1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b677d30>, '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 0x10b4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b66fb20>, '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.I2durOYlWF/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.tq4NTUJgHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 05:33:26 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 05:33:26 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 05:33:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I2durOYlWF/Render', 05:33:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:26 INFO - 'HOME': '/Users/cltbld', 05:33:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:26 INFO - 'LOGNAME': 'cltbld', 05:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:26 INFO - 'MOZ_NO_REMOTE': '1', 05:33:26 INFO - 'NO_EM_RESTART': '1', 05:33:26 INFO - 'PAGER': '/bin/cat', 05:33:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:26 INFO - 'PWD': '/builds/slave/test', 05:33:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:26 INFO - 'SHELL': '/bin/bash', 05:33:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tq4NTUJgHm/Listeners', 05:33:26 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 05:33:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:26 INFO - 'USER': 'cltbld', 05:33:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:26 INFO - 'XPC_FLAGS': '0x0', 05:33:26 INFO - 'XPC_SERVICE_NAME': '0', 05:33:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:27 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)) 05:33:27 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)) 05:33:27 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)) 05:33:27 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)) 05:33:27 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)) 05:33:27 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)) 05:33:27 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)) 05:33:27 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)) 05:33:27 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)) 05:33:27 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)) 05:33:27 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)) 05:33:27 INFO - Cleaning up... 05:33:27 INFO - Return code: 0 05:33:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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')]} 05:33:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:27 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 0x10b863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9785a1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b677d30>, '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 0x10b4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b66fb20>, '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.I2durOYlWF/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.tq4NTUJgHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 05:33:27 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 05:33:27 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 05:33:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I2durOYlWF/Render', 05:33:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:27 INFO - 'HOME': '/Users/cltbld', 05:33:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:27 INFO - 'LOGNAME': 'cltbld', 05:33:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:27 INFO - 'MOZ_NO_REMOTE': '1', 05:33:27 INFO - 'NO_EM_RESTART': '1', 05:33:27 INFO - 'PAGER': '/bin/cat', 05:33:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:27 INFO - 'PWD': '/builds/slave/test', 05:33:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:27 INFO - 'SHELL': '/bin/bash', 05:33:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tq4NTUJgHm/Listeners', 05:33:27 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 05:33:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:27 INFO - 'USER': 'cltbld', 05:33:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:27 INFO - 'XPC_FLAGS': '0x0', 05:33:27 INFO - 'XPC_SERVICE_NAME': '0', 05:33:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:33:27 INFO - Cleaning up... 05:33:27 INFO - Return code: 0 05:33:27 INFO - Running post-action listener: _resource_record_post_action 05:33:27 INFO - Running post-action listener: _start_resource_monitoring 05:33:27 INFO - Starting resource monitoring. 05:33:27 INFO - [mozharness: 2017-01-03 13:33:27.502956Z] Finished create-virtualenv step (success) 05:33:27 INFO - [mozharness: 2017-01-03 13:33:27.503883Z] Running install step. 05:33:27 INFO - Running pre-action listener: _resource_record_pre_action 05:33:27 INFO - Running main action method: install 05:33:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:27 INFO - Reading from file tmpfile_stdout 05:33:27 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:33:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:33:27 INFO - Reading from file tmpfile_stdout 05:33:27 INFO - Output received: 05:33:27 INFO - Usage: mozinstall [options] installer 05:33:27 INFO - Options: 05:33:27 INFO - -h, --help show this help message and exit 05:33:27 INFO - -d DEST, --destination=DEST 05:33:27 INFO - Directory to install application into. [default: 05:33:27 INFO - "/builds/slave/test"] 05:33:27 INFO - --app=APP Application being installed. [default: firefox] 05:33:27 INFO - mkdir: /builds/slave/test/build/application 05:33:27 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'] 05:33:27 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 05:33:50 INFO - Reading from file tmpfile_stdout 05:33:50 INFO - Output received: 05:33:50 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:33:50 INFO - Running post-action listener: _resource_record_post_action 05:33:50 INFO - [mozharness: 2017-01-03 13:33:50.336629Z] Finished install step (success) 05:33:50 INFO - [mozharness: 2017-01-03 13:33:50.336758Z] Running run-tests step. 05:33:50 INFO - Running pre-action listener: _resource_record_pre_action 05:33:50 INFO - Running main action method: run_tests 05:33:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:50 INFO - 2017-01-03 05:33:50.351 screenresolution[1627:7909] starting screenresolution argv=screenresolution get 05:33:50 INFO - 2017-01-03 05:33:50.353 screenresolution[1627:7909] Display 0: 1600x1200x32@60 05:33:50 INFO - 2017-01-03 05:33:50.359 screenresolution[1628:7912] starting screenresolution argv=screenresolution list 05:33:50 INFO - Available Modes on Display 0 05:33:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:50 INFO - Intel Iris: 05:33:50 INFO - Chipset Model: Intel Iris 05:33:50 INFO - Type: GPU 05:33:50 INFO - Bus: Built-In 05:33:50 INFO - VRAM (Dynamic, Max): 1536 MB 05:33:50 INFO - Vendor: Intel (0x8086) 05:33:50 INFO - Device ID: 0x0a2e 05:33:50 INFO - Revision ID: 0x0009 05:33:50 INFO - Displays: 05:33:50 INFO - Display: 05:33:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:50 INFO - Display Serial Number: 1600x1200 60 05:33:50 INFO - Main Display: Yes 05:33:50 INFO - Mirror: Off 05:33:50 INFO - Online: Yes 05:33:50 INFO - Rotation: Supported 05:33:50 INFO - Return code: 0 05:33:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:50 INFO - Python 2.7.3 05:33:50 INFO - Return code: 0 05:33:50 INFO - grabbing minidump binary from tooltool 05:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:50 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 0x10b677d30>, '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 0x10b4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b66fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:50 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 05:33:50 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 05:33:50 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 05:33:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:50 INFO - Return code: 0 05:33:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:50 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', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:33:50 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 --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I2durOYlWF/Render', 05:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:50 INFO - 'HOME': '/Users/cltbld', 05:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:50 INFO - 'LOGNAME': 'cltbld', 05:33:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:50 INFO - 'MOZ_NO_REMOTE': '1', 05:33:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:50 INFO - 'NO_EM_RESTART': '1', 05:33:50 INFO - 'PAGER': '/bin/cat', 05:33:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:50 INFO - 'PWD': '/builds/slave/test', 05:33:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:50 INFO - 'SHELL': '/bin/bash', 05:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tq4NTUJgHm/Listeners', 05:33:50 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 05:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:50 INFO - 'USER': 'cltbld', 05:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:50 INFO - 'XPC_FLAGS': '0x0', 05:33:50 INFO - 'XPC_SERVICE_NAME': '0', 05:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:33:50 INFO - mozversion application_buildid: 20170103031119 05:33:50 INFO - mozversion application_changeset: 0a17d39220700e742bf37a960967480b2f8159f1 05:33:50 INFO - mozversion application_display_name: Firefox 05:33:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:50 INFO - mozversion application_name: Firefox 05:33:50 INFO - mozversion application_remotingname: firefox 05:33:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:33:50 INFO - mozversion application_vendor: Mozilla 05:33:50 INFO - mozversion application_version: 51.0 05:33:50 INFO - mozversion platform_buildid: 20170103031119 05:33:50 INFO - mozversion platform_changeset: 0a17d39220700e742bf37a960967480b2f8159f1 05:33:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:33:50 INFO - mozversion platform_version: 51.0 05:33:50 INFO - using testdate: 1483450430 05:33:50 INFO - actual date: 1483450430 05:33:50 INFO - starting webserver on 'localhost:49236' 05:33:50 INFO - SUITE-START | Running 2 tests 05:33:50 INFO - TEST-START | dromaeo_css 05:33:50 INFO - operating with platform_type : mac_ 05:33:50 INFO - Initialising browser for dromaeo_css test... 05:33:50 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpX24uy3/profile http://localhost:49236/getInfo.html) 05:33:53 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 05:33:53 INFO - PROCESS | 1638 | colorDepth:24 05:33:53 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 05:33:53 INFO - PROCESS | 1638 | __metrics 05:33:53 INFO - PROCESS | 1638 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:33:53 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:33:54 INFO - TEST-INFO | 1638: exit 0 05:33:54 INFO - Browser initialized. 05:33:54 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:54 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpX24uy3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:06 INFO - PROCESS | 1642 | RSS: Main: 168509440 05:34:06 INFO - PROCESS | 1642 | 05:35:02 INFO - PROCESS | 1642 | 1483450502108 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] 05:37:08 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 05:37:09 INFO - PROCESS | 1642 | RSS: Main: 299548672 05:37:09 INFO - PROCESS | 1642 | 05:40:12 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 05:40:13 INFO - PROCESS | 1642 | RSS: Main: 301453312 05:40:13 INFO - PROCESS | 1642 | 05:43:15 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 05:43:16 INFO - PROCESS | 1642 | RSS: Main: 277573632 05:43:16 INFO - PROCESS | 1642 | 05:46:18 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 05:46:18 INFO - PROCESS | 1642 | RSS: Main: 283766784 05:46:18 INFO - PROCESS | 1642 | 05:49:22 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 05:49:22 INFO - PROCESS | 1642 | RSS: Main: 262713344 05:49:22 INFO - PROCESS | 1642 | 05:52:25 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 05:52:25 INFO - PROCESS | 1642 | RSS: Main: 306573312 05:52:25 INFO - PROCESS | 1642 | 05:52:25 INFO - PROCESS | 1642 | __start_tp_report 05:52:25 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 05:52:25 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 05:52:25 INFO - PROCESS | 1642 | |i|pagename|runs| 05:52:25 INFO - PROCESS | 1642 | |0;dojo.html;3246.1722260823485;3328.36761015407;3482.7213822894173;3486.7733597316155;3541.0262177901072;5705.286839145107;5796.9710151449235;5807.30312362516;5824.359320474744;5876.794312199074;5696.458836410545;5765.509931655814;5845.766169353232;5852.414758524145;5852.941470585293;5238.895222095556;5307.52232299093;5318.760655770499;5326.786928522854;5360.839174824761;5300.575953923677;5317.680939143664;5326.573874090082;5371.543418809406;5377.516023557879;5369.704666243355;5381.48875856793;5386.272853164812;5390.110631745757;5391.56867450603;5298.152295632719;5364.168553874156;5365.222042803791;5373.328333958255;5381.67709937405;5163.096458119814;5238.711870847102;5307.336582927134;5308.495692909168;5328.094223981893;5941.524678025748;5984.371640977722;5999.190109335271;6014.248218972629;6021.36775638556;6161.938380616226;6223.284322302948;6285.842853928642;6293.559450838443;6305.432511073979;6130.581587307925;6165.537584681167;6259.029850373199;6259.217597800275;6266.4360207581085;5254.474552544715;5785.537157027427;5874.102222310677;5964.522838172936;6016.338202797689;6256.499480041586;6349.904751428732;6355.809325720235;6373.139626150411;6377.7767778127545;6084.361142080106;6154.630722156685;6187.907181392283;6193.102000209944;6277.843053923597;5116.641835071509;5244.239585260192;6359.586626869239;6363.649999249993;6367.4906007519285;6145.692715364214;6286.277078136073;6307.369263073656;6319.526035547352;6324.335944725737;6113.319832214623;6205.937940620626;6279.183706118175;6295.118683384329;6306.054091886253;5020.322256495327;5024.120778863684;5028.823991160365;5036.748162591855;5041.6722913010535;4418.889527761831;4537.047220083753;4539.296409056601;4541.591256786839;4549.067441174551;5856.736446859902;5879.235699359056;5941.554383421174;5952.255968003999;5952.672603006876;6239.750409983641;6265.498760099181;6341.619502829845;6347.0479428086155;6362.141110950055;6014.9699251504335;6027.065804800263;6057.182280392179;6065.181200537959;6079.817605471843;5442.319710036246;5488.286522752017;5496.7526461309335;5511.035568775448;5522.9447705523235;6270.435660790551;6290.874182516415;6318.715657795318;6403.103565500834;6426.196725409324;6293.433590976834;6320.494360451245;6352.587081839665;6356.141920840627;6363.5863668861375;6358.713857876499;6376.234851817811;6397.0724244983285;6422.582532135396;6427.614343139427;6142.560166306883;6182.752689892533;6207.193064901534;6306.558540902093;6308.873822523616;5224.320838290998;6248.500119990481;6330.556861019869;6355.046742988588;6375.6174629522375;6202;6213.1922850029205;6232.314445410911;6245.250569931455;6260.937390626218;6042.1540984261355;6093.512518998558;6139.522803442411;6226.470749986302;6236.064590311489;6055.364186760326;6091.882314775641;6139.062858969336;6149.169862068742;6160.537959652955;6212.596181248205;6219;6225.408586184486;6226.906596400967;6242.937570624235;5817.389174136655;5932.614380065282;6083.908741368795;6095.573309868267;6121.081837724377 05:52:25 INFO - PROCESS | 1642 | |1;ext.html;495.63323140875764;529.7483695244758;543.3751186135945;545.280230096273;555.4029418375246;27517;32384.19039524013;33724.494132588;42123.57876421235;43134;43745.562544374545;44024.55975440245;44097.7795111024;44221.77889110558;44260.893477663;9930.056644618768;10114.747131321703;10116.696499105039;10119.696409107739;10132.54403551842;9218.58516366765;9449.338546301762;12194.207376520499;12463.252204867737;12471.189372690746;12250.509979600805;12306.20009699371;12352.320622365767;12352.44414001372;12353.07351948603;12198.634040978784;12300.876991230063;12311.630651080482;12321.5071397144;12325.568605098779;12198.390080496029;12255.75488490234;12272.018238540895;12274.018078553783;12294.20087694297;41855.581444185475;42059.738207853814;42060.57939420628;42103.7894810524;42139;3516.8241587920757;3613.259281847215;3663.249033948034;3730.794806285653;4389.780510974439;31801.363972720417;32038.519422208687;32145.6785432145;32467.83766081178;32589.511157332658;3248.8953755722932;3278.60656721195;3348.0625424881073;3374.0552645259368;3379.662033796625;540808.5919140797;546904;547559;547768;548737.2563137199;53498.732506338;63034;63482.68258658677;63514.36485635177;63654.363456364845;36552.63447365545;37168;37283.81358093192;38479.422808657895;66544;17679;17826.821731782777;17839.286428542713;17858.46424607264;17894.731579026324;12372.44324005422;12591.811122833165;13414.396352164176;13594.11638243511;13611.319434028457;17524.47426577205;17684;17685.027323497332;19422.116657658295;20621.690674639893;7817.374610031184;7879.645415956295;7915.762527124196;7916.287534121957;7966.482178658369;911.6171208092617;948.2603569216022;963.4604621412032;1006.3006210683504;1059.06802014227;31184.53223201654;31251.84374078115;31255.06234812959;31557.21106972298;31929.361412771614;966.5312323523086;967.4533888353058;1082.3397727386289;1094.5402930769096;1103.6964834670368;15349.386024558893;15937.12345820991;15969.920150399406;16103.67792644164;16241.187940603158;718044;722694;723310;724745;726285;60548.697256513435;60955.08567371493;61033.69483152556;61195;61603.38396616066;1273.891719203878;1316.822228999092;1363.16165558181;1410.1116296732991;1427;31106.22234444157;32478.67521324851;32786.836065819516;32921.02473851576;33545.329093418484;51074;51364.48635513597;51519.96960060853;51584.48415515797;51789;578265;579379.2062079494;579537;580298;580745;24608;25277.368065798502;27186.592201116604;27199.59200611953;27700.584491232243;47255;48260;48587;49088.01823963572;49144.262836056776;30732.385352292382;36254.8187259062;37983.81008094942;40551;41094.38358424686;40015.59984400119;40573.985650358976;41105.972350691474;41272;42079.36880946727;39306.803465982484;39904.60095399009;40058.799706001286;40265;40313.395299071126;33692.66307336895;34912.650873491955;35177.82411087928;35706.821465892506;35842.10394740048;26079.739202607732;26188;26304.73695263023;26382.73617263803;26815.597766033916 05:52:25 INFO - PROCESS | 1642 | |2;jquery.html;370.6904734546653;378.78787878787875;391.11412650346966;399.3231472653853;405.53768703677815;19464.610707785836;21357.359279221608;21965.121395144193;22220.111195552177;23171.420714482145;20982.37052888412;21344.57310853782;21584.13663453464;22127.668084978737;22462;5022.748862556876;5580.888382232373;6377.266614339341;6417.197850268716;6434.324395938429;4015.538213105501;4573;6260.092286618437;6399.328070552595;6401.647909364983;4576.084783043388;7162.64186790661;7239.638018099074;7246.710131594757;7269.6728647211;7132.860141957418;7160.928390716131;7191.496595238335;7193.856122877513;7212.3148300911325;6174.567780255384;6245.313015568284;6252.53106017046;6254.6247225166635;6256.843578910518;27178.5923211152;27727.86136069327;27772.30569235765;28133.43733125326;28410;2170.967435488469;2251.887405629712;2347.4483496378507;2510.33476128826;2796.2170592234206;10481.63314284004;10495.842562361571;10527.578896844117;10830.512626931806;11060.612878549213;1644.4326707285968;1968.8129627685346;1978.3669225847734;1982.4250967219489;1990.263602467082;108314;112192;112883;113836;116092.18297164552;11768.352740599177;11908.404579770977;11910.464029118537;11969.760604787856;12087.153899227145;15175.924120379548;15203;15220.847791522165;15237.923810380877;15290.541283761506;8808.339374546935;9141.725748227564;9175.58709858058;9234.676786312446;9288;9118.726438206864;9135.817283654289;9144.8628270576;9278.62885484573;9306.348555601044;4592.770361481913;4661.230896902041;4667.276572131325;4739.644526660514;4785.59322457595;1873.9531511712044;1919.64486569985;1926.1524929031182;1926.9325573605138;1936.351322307043;869.826034793044;941.5339406993583;969.7187815533557;1024.9641262555924;1037.3153718545875;20358;23085.653715194287;23332.300030999097;23354.18260360879;23403.180888668816;867.2940425871196;943.2783920300975;964.2334344196381;967.351874244258;981.4994352880083;9759.853602195974;11262.774744505228;11936.448261726093;11971.52113915451;12022.398880055962;575831;646056;650392;661105;668145;89047.66428503577;104540.47729761302;119455;139925.60074399126;149204;978.6379039755194;1006.6476733143342;1059.5708737961138;1060.5068643081004;1064.1965316186383;19247.807521925162;20941.891264983587;21004.47488812792;21184;21256.36230913013;53441.732791335795;53592.19611705906;57642.42357576371;58391;58473.24580262599;83342.16657833345;86014.56992714996;86046;86217;86802.56598716966;8312.87530687028;8436.915630843612;8637;8706.259967902799;8788.868166977372;11907.166498345032;13262.602121936357;13461.192328460324;13633.931830340785;13743.244121573409;9820.067093626094;11399.95301667896;11592.072634189077;11757.353345565734;11932.403379831147;10506.159507239556;10748.677539673823;11391.943040284745;11457.484413201593;11673.766524669629;11436.599719010128;11801.992750034624;12054.819177712518;12106.092043096627;12208.81686774717;8485.066642669424;8647.740567782977;8678.392512524062;8708.651653934025;8782.429142105742;10108.646197383056;11678.124140689313;11701.88298117008;11792.174547781917;11976.041916646473 05:52:25 INFO - PROCESS | 1642 | |3;mootools.html;1542.275130688576;1556.4085647453967;1756.9209385577649;1892.3944337811906;1898.0320036781245;8562.957185214073;9077.455352678844;9077.591508382122;9093.227075698573;9100.544972751353;7877.4485785995;8145.389095817808;8159.877601835978;8256.215659512352;8855.203031727144;2163.891805409731;2209.856359336646;2304.850184737995;2373.2998765364173;2384.6661467394492;2384.3204686664303;2386.570417324881;2388.4028992751814;2389.175734371639;2393.3777217923293;2352.541254455382;2414.239514552919;2415.661807346964;2415.915442959497;2416.2388847512975;2154.84715677112;2365.9763402366016;2379.1078345620394;2399.0883464283634;2399.3401814500976;2284.12061356379;2312.976870231293;2365.9645105323434;2381.8094552435764;2397.2448678666165;8826;9019.331423686639;9037;9040.321975851837;9040.728778136667;5345.866353341197;5516.255305533782;5520.923419933115;5527.53015993641;5535.225068490415;3516.3670539302916;3619.7466177367596;3686.4286035664513;3699.3711069118312;3701.3152566775234;1053.6628278950739;1092.5848177692505;1118.9384583847884;1121.938293393863;1123.039800970175;11761.411929403495;11796.29222246668;11796.646100616996;11801.350925699084;11804;4769.213079841857;4797.520247975174;4869.366982292279;4914.017196560702;4948.158813001798;10137.239707022003;10137.98620137995;10138.898611013943;10142.239332050125;10146.797064058677;5524.779008839601;5525.336959564878;5525.806596769094;5530.557555395559;5532.806351777668;4517.841875534341;4885.071836351153;4983.352164218701;5081.085404627129;5086.669366491166;3174.698403651649;3911.3741801311653;3981.482407287034;4094.201630682048;4097.795110244536;1282.8588855225917;1296.883280504759;1297.8896793772446;1311.7442098790834;1315.8684131586765;773.7137259214014;882.342654722236;912.2519533982071;915.4644532948166;919.9788235059079;5818.127280907897;5820;5905.40945905406;5934.821955341346;6145.723442445101;914.291424146292;978.9706308810747;983.6360546597805;995.6913356859396;1036.404067661098;3432.742544309137;3953.9011524711536;4067.877963661095;4079.755214687128;4118.135191609796;10437.165026797838;10797.514111864984;10855.782884342427;10982.395968221665;11039.889601103887;10895.237333386745;10924.781504369868;10932.344059356465;10947.124230061576;10955.50700218492;8303.584820758937;8553.059163492011;8553.57232138403;8559.614817333235;8579.828403431897;5614.129809879475;5859.531237501075;5932.851678707894;6141.140240366263;6173.84565385869;9547.379420337656;10063.899361006297;10233.48832558384;10315;10332.896671033493;10389.480525973822;10395.168386528909;10399.1160751337;10405;10407.84388234162;6097.481714054177;7674.347680447225;7817.5309481431295;7830.8825367620675;8076.757697269091;7703.345215656732;7993.080795708568;8339.583020848811;8472.83054338922;8624.353173512138;7518.473706840688;7573.129090154703;7646.006019217466;7672.38620910337;7720.8455830884195;7407.962960185165;7433.516821406592;7457.179710231979;7465.4027677786735;7533.773986780406;6854.588724676535;6979.616121113185;7030.437564994891;7127.928720712726;7135.429165666838;4926.5073492650445;5006.899862002812;5026.648134630541;5053.797848086036;5064.442911279682;4884.291777692144;4913.729744864067;4930.7534623267975;4976.552110310089;5080.034793389244 05:52:25 INFO - PROCESS | 1642 | |4;prototype.html;257.3104081062752;299.31606279651004;311.56847765844304;317.87126213883386;321.6188816252739;4472.741265660845;5276.512427075846;5276.525112739852;5353.304070470838;5382.761964748111;4022.4770779798587;4251.574842515747;4630.699004564701;5089.676684062152;5209.843704688856;4044.029432936089;4068.8982775430554;4092.774897380643;4095.7747323897174;4100.466939297902;4089.407035979781;4096.713230073896;4099.221147981889;4102.7128101032795;4128.669706423494;3923.3722604383306;4051.331530297512;4076.5311989121187;4077.5922407759285;4084.2035803018425;3795.35478968576;3813.561440434344;3997.2405243003736;4052.959470405288;4053.1893621275567;3543.362194804934;3544.131687736521;3564.4475106358555;3567.8037707926055;3571.910702232439;3995.122292522539;4537.523560026183;5093.376910890857;5128.333316668809;5153.433122356538;3927.5483319418345;4348.934765978513;4557.903364452356;4619.8219454039345;4628.745419001953;4929.901401971941;5215.895682086375;5516.531094856942;5522.282103326582;5527.778888844441;3872.9031774205587;3873.1672690371706;3886.9116647338506;3900.258950799339;3920.764754114762;5187.714675692835;5463.562914966793;5657.1514272858985;5747.3103227612955;5827.446392592697;3233.3694929488524;3256.5929258842643;3799.4490798834568;3834.827432765532;3839.2897313997;3996.5603783583783;4009.3585026395635;4026.657734092635;4027.3958906163725;4085.816138273785;3929.7011248419994;3957.920841583152;4628.190066738307;4669.439667239885;4678.8128474861305;4207.389928460356;5501.257330260363;5507.421720719267;5520.530754885799;5602.551795856321;1342.02703040295;1361.686812033218;1365.3582816076428;1370.0341259412091;1379.0140049864394;885.93798434109;926.2682480840061;940.6378544260509;948.4025064209504;949.1457688080644;4469.932951005738;5285.524302812689;5286.515337791232;5321.308229930084;5344.545713614309;5644.887102258014;5660.801871934463;5683.516901063456;5685.3177618685195;5688.984838035765;4928.359313289249;5045.722485263345;5310.495502927216;5314.256004159421;5319.707416092075;2206.4594174427366;2247.797698207169;2480.2931164618;2516.6476693262957;2520.1099175618288;4337.900683853728;4602.516735742765;4900.8774780630765;4934.55588996992;5023.372078490189;4371.819608705695;4487.833163377545;4818.6626936114135;4853.563179313808;4958.157427993334;4202.978985105116;4818.698951283134;4894.706317620954;4933.506649335038;4955.653104282737;3932.941005884971;4420.170836058233;4602.182138055382;4699.882502937454;4730.526947305242;4661.270983213483;4691.451820899163;4724.244120940633;5124.871878203075;5771.653700777967;5694.829155125353;5906.320773110975;6040.909386359121;6055.666938318259;6055.878882422238;3812.199438117915;3814.8664796731982;3839.5584507781964;3852.6725228355904;3852.807359631951;5577.721113944205;5781.884362312814;5797.130430435468;5823.708814559171;5840.532757379315;4849.296851956376;5178.6374953752875;5603.327600687943;5689.288838895138;5694.174344720075;5607.271054762855;5608.7099967008635;5611.482756381152;5631;5649.519790817662;5506.614536982533;5513.917291240715;5521.944780552143;5541.5289700375915;5542.976813463138;4862.95137048625;5000.199968005102;5134.075866344094;5626;5660.462256085665;4397.494288156903;4573.588377046081;5218.6868787872845;5489.945100548944;5506.449355064622 05:52:25 INFO - PROCESS | 1642 | |5;yui.html;702.8875379939211;777.3198451355064;779.1468342165327;784.9999999999999;840.2102024097352;15812.525624231277;17007.659846803057;17026;17059.829401705978;17065.14674266288;15247;15358.308876100575;15358.462453814118;15360.61598460039;15366;718.4216705552028;731.5829976913161;875.8248350329943;887.1970866365917;902.9774255643596;875.916787905148;893.865920111982;894.8568229083348;895.0601868038566;895.7850115972152;945.8675785390051;946.9242460603135;947.3794664494767;949.7245798718363;949.9287553433486;942.8208640358345;943.2265542255353;943.8065196634674;943.9811203775886;946.394307643109;699.9090118284641;700.0269625220897;700.8563244534859;701.1586096683949;701.5650296815955;15504.689906201813;15534.844651553565;15537.766933496006;15574.299156537983;15593.532194034196;13853.238071906042;13855.722885542233;14058.437662493488;14139.363728632236;14179.36192871313;12783.680407989874;12791.976641868721;13564.525241616595;13745.793813092812;14429.35067921946;4656.557627025427;4691.483936766987;4718.0328032753205;4756.500567440438;4913.06651736169;119616.40191799072;120900;121640;121708.39145804303;126308.63222310036;11470;11569.363684997237;11696;11716.414179291001;11817.822732659017;23368.76631233666;23526.64710029351;23924.52150956971;24048.15831445926;24345.75654243435;7181.856362872713;8448;8479.109693482218;8697.826043479095;8816.823663526693;4343.1747967886;4345.9348109778375;4613.677042606985;4705.858894023438;4926.679765815211;3704.6110158432975;3797.1456422305314;3814.427835824593;3845.8461661533224;3846.8845934622004;603.2188316130621;668.3850857211377;693.9028536004963;698.12734082397;705.3898377903076;510.8416390918827;548.6625725179066;668.1514476614672;695.8330000799772;712.9144502659714;9234;9791.51042447889;10057.647982320585;10160.593576257015;10186.490675466197;623.6227082615044;670.76858483823;693.8979544363436;703.4969996452561;732.4177279063158;4750.009991606998;4950.5489340438;4977.776000080005;5012.8496145115705;5203.739813009334;165038;166093;168619;169463.81702287213;170850.2914970859;106140;120920;129320;138831;138846.3057684705;122798;127750.36124819316;127891.72108278798;128359;130705;9888.555015024198;10209.132223761064;10229.48852557384;10271.281010329205;10277.331973421704;69023.65488172729;69461.65269173622;69757.30242697507;70682.64658676674;72609.6369518149;102408;105164.94835051552;108088.4595577017;109094;111668.41657917234;13299.154113902037;13604.04771665974;13618.863811362156;13914.02601817863;14064.226467544384;15365.846341536888;15953.282102305191;16250.3499860009;16832.57918552046;16873.662526749642;14933.925330373278;14956;15097.924510377377;15563.221838907783;15610.843891561393;14244.145351278956;14393.64015899569;14397.120575885074;14530.346134423766;14762.114273143647;13798.241096739373;13985.58043258704;14165.504207352693;14525.571305458992;14692.485762998243;11114.277571957797;12129.575464858688;12248.571300004458;12250.632481025583;12268.386580670753;11717.531298747954;11859.22915010556;12066.155369124077;12159.452824622736;12169.391530423267 05:52:25 INFO - PROCESS | 1642 | __end_tp_report 05:52:25 INFO - PROCESS | 1642 | __start_cc_report 05:52:25 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1235 05:52:25 INFO - PROCESS | 1642 | __end_cc_report 05:52:25 INFO - PROCESS | 1642 | __startTimestamp1483451545921__endTimestamp 05:52:25 INFO - PROCESS | 1642 | 05:52:25 INFO - PROCESS | 1642 | ------- Summary: start ------- 05:52:25 INFO - PROCESS | 1642 | Number of tests: 6 05:52:25 INFO - PROCESS | 1642 | 05:52:25 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5827.64 Median:6083.91 stddev:635.78 (10.5%) stddev-sans-first:604.61 05:52:25 INFO - PROCESS | 1642 | Values: 3246.2 3328.4 3482.7 3486.8 3541.0 5705.3 5797.0 5807.3 5824.4 5876.8 5696.5 5765.5 5845.8 5852.4 5852.9 5238.9 5307.5 5318.8 5326.8 5360.8 5300.6 5317.7 5326.6 5371.5 5377.5 5369.7 5381.5 5386.3 5390.1 5391.6 5298.2 5364.2 5365.2 5373.3 5381.7 5163.1 5238.7 5307.3 5308.5 5328.1 5941.5 5984.4 5999.2 6014.2 6021.4 6161.9 6223.3 6285.8 6293.6 6305.4 6130.6 6165.5 6259.0 6259.2 6266.4 5254.5 5785.5 5874.1 5964.5 6016.3 6256.5 6349.9 6355.8 6373.1 6377.8 6084.4 6154.6 6187.9 6193.1 6277.8 5116.6 5244.2 6359.6 6363.6 6367.5 6145.7 6286.3 6307.4 6319.5 6324.3 6113.3 6205.9 6279.2 6295.1 6306.1 5020.3 5024.1 5028.8 5036.7 5041.7 4418.9 4537.0 4539.3 4541.6 4549.1 5856.7 5879.2 5941.6 5952.3 5952.7 6239.8 6265.5 6341.6 6347.0 6362.1 6015.0 6027.1 6057.2 6065.2 6079.8 5442.3 5488.3 5496.8 5511.0 5522.9 6270.4 6290.9 6318.7 6403.1 6426.2 6293.4 6320.5 6352.6 6356.1 6363.6 6358.7 6376.2 6397.1 6422.6 6427.6 6142.6 6182.8 6207.2 6306.6 6308.9 5224.3 6248.5 6330.6 6355.0 6375.6 6202.0 6213.2 6232.3 6245.3 6260.9 6042.2 6093.5 6139.5 6226.5 6236.1 6055.4 6091.9 6139.1 6149.2 6160.5 6212.6 6219.0 6225.4 6226.9 6242.9 5817.4 5932.6 6083.9 6095.6 6121.1 05:52:25 INFO - PROCESS | 1642 | 05:52:25 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:74482.18 Median:35774.46 stddev:166239.62 (464.7%) stddev-sans-first:166613.15 05:52:25 INFO - PROCESS | 1642 | Values: 495.6 529.7 543.4 545.3 555.4 27517.0 32384.2 33724.5 42123.6 43134.0 43745.6 44024.6 44097.8 44221.8 44260.9 9930.1 10114.7 10116.7 10119.7 10132.5 9218.6 9449.3 12194.2 12463.3 12471.2 12250.5 12306.2 12352.3 12352.4 12353.1 12198.6 12300.9 12311.6 12321.5 12325.6 12198.4 12255.8 12272.0 12274.0 12294.2 41855.6 42059.7 42060.6 42103.8 42139.0 3516.8 3613.3 3663.2 3730.8 4389.8 31801.4 32038.5 32145.7 32467.8 32589.5 3248.9 3278.6 3348.1 3374.1 3379.7 540808.6 546904.0 547559.0 547768.0 548737.3 53498.7 63034.0 63482.7 63514.4 63654.4 36552.6 37168.0 37283.8 38479.4 66544.0 17679.0 17826.8 17839.3 17858.5 17894.7 12372.4 12591.8 13414.4 13594.1 13611.3 17524.5 17684.0 17685.0 19422.1 20621.7 7817.4 7879.6 7915.8 7916.3 7966.5 911.6 948.3 963.5 1006.3 1059.1 31184.5 31251.8 31255.1 31557.2 31929.4 966.5 967.5 1082.3 1094.5 1103.7 15349.4 15937.1 15969.9 16103.7 16241.2 718044.0 722694.0 723310.0 724745.0 726285.0 60548.7 60955.1 61033.7 61195.0 61603.4 1273.9 1316.8 1363.2 1410.1 1427.0 31106.2 32478.7 32786.8 32921.0 33545.3 51074.0 51364.5 51520.0 51584.5 51789.0 578265.0 579379.2 579537.0 580298.0 580745.0 24608.0 25277.4 27186.6 27199.6 27700.6 47255.0 48260.0 48587.0 49088.0 49144.3 30732.4 36254.8 37983.8 40551.0 41094.4 40015.6 40574.0 41106.0 41272.0 42079.4 39306.8 39904.6 40058.8 40265.0 40313.4 33692.7 34912.7 35177.8 35706.8 35842.1 26079.7 26188.0 26304.7 26382.7 26815.6 05:52:25 INFO - PROCESS | 1642 | 05:52:25 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:36658.60 Median:2428.89 stddev:106423.26 (4381.6%) stddev-sans-first:106686.92 05:52:25 INFO - PROCESS | 1642 | Values: 370.7 378.8 391.1 399.3 405.5 19464.6 21357.4 21965.1 22220.1 23171.4 20982.4 21344.6 21584.1 22127.7 22462.0 5022.7 5580.9 6377.3 6417.2 6434.3 4015.5 4573.0 6260.1 6399.3 6401.6 4576.1 7162.6 7239.6 7246.7 7269.7 7132.9 7160.9 7191.5 7193.9 7212.3 6174.6 6245.3 6252.5 6254.6 6256.8 27178.6 27727.9 27772.3 28133.4 28410.0 2171.0 2251.9 2347.4 2510.3 2796.2 10481.6 10495.8 10527.6 10830.5 11060.6 1644.4 1968.8 1978.4 1982.4 1990.3 108314.0 112192.0 112883.0 113836.0 116092.2 11768.4 11908.4 11910.5 11969.8 12087.2 15175.9 15203.0 15220.8 15237.9 15290.5 8808.3 9141.7 9175.6 9234.7 9288.0 9118.7 9135.8 9144.9 9278.6 9306.3 4592.8 4661.2 4667.3 4739.6 4785.6 1874.0 1919.6 1926.2 1926.9 1936.4 869.8 941.5 969.7 1025.0 1037.3 20358.0 23085.7 23332.3 23354.2 23403.2 867.3 943.3 964.2 967.4 981.5 9759.9 11262.8 11936.4 11971.5 12022.4 575831.0 646056.0 650392.0 661105.0 668145.0 89047.7 104540.5 119455.0 139925.6 149204.0 978.6 1006.6 1059.6 1060.5 1064.2 19247.8 20941.9 21004.5 21184.0 21256.4 53441.7 53592.2 57642.4 58391.0 58473.2 83342.2 86014.6 86046.0 86217.0 86802.6 8312.9 8436.9 8637.0 8706.3 8788.9 11907.2 13262.6 13461.2 13633.9 13743.2 9820.1 11400.0 11592.1 11757.4 11932.4 10506.2 10748.7 11391.9 11457.5 11673.8 11436.6 11802.0 12054.8 12106.1 12208.8 8485.1 8647.7 8678.4 8708.7 8782.4 10108.6 11678.1 11701.9 11792.2 11976.0 05:52:25 INFO - PROCESS | 1642 | 05:52:25 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5793.97 Median:4899.40 stddev:3250.01 (66.3%) stddev-sans-first:3243.42 05:52:25 INFO - PROCESS | 1642 | Values: 1542.3 1556.4 1756.9 1892.4 1898.0 8563.0 9077.5 9077.6 9093.2 9100.5 7877.4 8145.4 8159.9 8256.2 8855.2 2163.9 2209.9 2304.9 2373.3 2384.7 2384.3 2386.6 2388.4 2389.2 2393.4 2352.5 2414.2 2415.7 2415.9 2416.2 2154.8 2366.0 2379.1 2399.1 2399.3 2284.1 2313.0 2366.0 2381.8 2397.2 8826.0 9019.3 9037.0 9040.3 9040.7 5345.9 5516.3 5520.9 5527.5 5535.2 3516.4 3619.7 3686.4 3699.4 3701.3 1053.7 1092.6 1118.9 1121.9 1123.0 11761.4 11796.3 11796.6 11801.4 11804.0 4769.2 4797.5 4869.4 4914.0 4948.2 10137.2 10138.0 10138.9 10142.2 10146.8 5524.8 5525.3 5525.8 5530.6 5532.8 4517.8 4885.1 4983.4 5081.1 5086.7 3174.7 3911.4 3981.5 4094.2 4097.8 1282.9 1296.9 1297.9 1311.7 1315.9 773.7 882.3 912.3 915.5 920.0 5818.1 5820.0 5905.4 5934.8 6145.7 914.3 979.0 983.6 995.7 1036.4 3432.7 3953.9 4067.9 4079.8 4118.1 10437.2 10797.5 10855.8 10982.4 11039.9 10895.2 10924.8 10932.3 10947.1 10955.5 8303.6 8553.1 8553.6 8559.6 8579.8 5614.1 5859.5 5932.9 6141.1 6173.8 9547.4 10063.9 10233.5 10315.0 10332.9 10389.5 10395.2 10399.1 10405.0 10407.8 6097.5 7674.3 7817.5 7830.9 8076.8 7703.3 7993.1 8339.6 8472.8 8624.4 7518.5 7573.1 7646.0 7672.4 7720.8 7408.0 7433.5 7457.2 7465.4 7533.8 6854.6 6979.6 7030.4 7127.9 7135.4 4926.5 5006.9 5026.6 5053.8 5064.4 4884.3 4913.7 4930.8 4976.6 5080.0 05:52:25 INFO - PROCESS | 1642 | 05:52:25 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4385.07 Median:4712.06 stddev:1331.23 (28.3%) stddev-sans-first:1298.41 05:52:25 INFO - PROCESS | 1642 | Values: 257.3 299.3 311.6 317.9 321.6 4472.7 5276.5 5276.5 5353.3 5382.8 4022.5 4251.6 4630.7 5089.7 5209.8 4044.0 4068.9 4092.8 4095.8 4100.5 4089.4 4096.7 4099.2 4102.7 4128.7 3923.4 4051.3 4076.5 4077.6 4084.2 3795.4 3813.6 3997.2 4053.0 4053.2 3543.4 3544.1 3564.4 3567.8 3571.9 3995.1 4537.5 5093.4 5128.3 5153.4 3927.5 4348.9 4557.9 4619.8 4628.7 4929.9 5215.9 5516.5 5522.3 5527.8 3872.9 3873.2 3886.9 3900.3 3920.8 5187.7 5463.6 5657.2 5747.3 5827.4 3233.4 3256.6 3799.4 3834.8 3839.3 3996.6 4009.4 4026.7 4027.4 4085.8 3929.7 3957.9 4628.2 4669.4 4678.8 4207.4 5501.3 5507.4 5520.5 5602.6 1342.0 1361.7 1365.4 1370.0 1379.0 885.9 926.3 940.6 948.4 949.1 4469.9 5285.5 5286.5 5321.3 5344.5 5644.9 5660.8 5683.5 5685.3 5689.0 4928.4 5045.7 5310.5 5314.3 5319.7 2206.5 2247.8 2480.3 2516.6 2520.1 4337.9 4602.5 4900.9 4934.6 5023.4 4371.8 4487.8 4818.7 4853.6 4958.2 4203.0 4818.7 4894.7 4933.5 4955.7 3932.9 4420.2 4602.2 4699.9 4730.5 4661.3 4691.5 4724.2 5124.9 5771.7 5694.8 5906.3 6040.9 6055.7 6055.9 3812.2 3814.9 3839.6 3852.7 3852.8 5577.7 5781.9 5797.1 5823.7 5840.5 4849.3 5178.6 5603.3 5689.3 5694.2 5607.3 5608.7 5611.5 5631.0 5649.5 5506.6 5513.9 5521.9 5541.5 5543.0 4863.0 5000.2 5134.1 5626.0 5660.5 4397.5 4573.6 5218.7 5489.9 5506.4 05:52:25 INFO - PROCESS | 1642 | 05:52:25 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:27335.10 Median:93168.74 stddev:43831.17 (47.0%) stddev-sans-first:43908.51 05:52:25 INFO - PROCESS | 1642 | Values: 702.9 777.3 779.1 785.0 840.2 15812.5 17007.7 17026.0 17059.8 17065.1 15247.0 15358.3 15358.5 15360.6 15366.0 718.4 731.6 875.8 887.2 903.0 875.9 893.9 894.9 895.1 895.8 945.9 946.9 947.4 949.7 949.9 942.8 943.2 943.8 944.0 946.4 699.9 700.0 700.9 701.2 701.6 15504.7 15534.8 15537.8 15574.3 15593.5 13853.2 13855.7 14058.4 14139.4 14179.4 12783.7 12792.0 13564.5 13745.8 14429.4 4656.6 4691.5 4718.0 4756.5 4913.1 119616.4 120900.0 121640.0 121708.4 126308.6 11470.0 11569.4 11696.0 11716.4 11817.8 23368.8 23526.6 23924.5 24048.2 24345.8 7181.9 8448.0 8479.1 8697.8 8816.8 4343.2 4345.9 4613.7 4705.9 4926.7 3704.6 3797.1 3814.4 3845.8 3846.9 603.2 668.4 693.9 698.1 705.4 510.8 548.7 668.2 695.8 712.9 9234.0 9791.5 10057.6 10160.6 10186.5 623.6 670.8 693.9 703.5 732.4 4750.0 4950.5 4977.8 5012.8 5203.7 165038.0 166093.0 168619.0 169463.8 170850.3 106140.0 120920.0 129320.0 138831.0 138846.3 122798.0 127750.4 127891.7 128359.0 130705.0 9888.6 10209.1 10229.5 10271.3 10277.3 69023.7 69461.7 69757.3 70682.6 72609.6 102408.0 105164.9 108088.5 109094.0 111668.4 13299.2 13604.0 13618.9 13914.0 14064.2 15365.8 15953.3 16250.3 16832.6 16873.7 14933.9 14956.0 15097.9 15563.2 15610.8 14244.1 14393.6 14397.1 14530.3 14762.1 13798.2 13985.6 14165.5 14525.6 14692.5 11114.3 12129.6 12248.6 12250.6 12268.4 11717.5 11859.2 12066.2 12159.5 12169.4 05:52:25 INFO - PROCESS | 1642 | -------- Summary: end -------- 05:52:25 INFO - PROCESS | 1642 | 05:52:26 INFO - TEST-INFO | 1642: exit 0 05:52:26 INFO - TEST-OK | dromaeo_css | took 1115554ms 05:52:26 INFO - TEST-START | kraken 05:52:26 INFO - operating with platform_type : mac_ 05:52:26 INFO - Initialising browser for kraken test... 05:52:26 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpEBHQel/profile http://localhost:49236/getInfo.html) 05:52:28 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 05:52:28 INFO - PROCESS | 1647 | colorDepth:24 05:52:28 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 05:52:28 INFO - PROCESS | 1647 | __metrics 05:52:28 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:52:28 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:52:29 INFO - TEST-INFO | 1647: exit 0 05:52:29 INFO - Browser initialized. 05:52:29 INFO - Running cycle 1/1 for kraken test... 05:52:29 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpEBHQel/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:41 INFO - PROCESS | 1649 | RSS: Main: 168857600 05:52:41 INFO - PROCESS | 1649 | 05:52:43 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:44 INFO - PROCESS | 1649 | RSS: Main: 218648576 05:52:44 INFO - PROCESS | 1649 | 05:52:47 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 05:52:47 INFO - PROCESS | 1649 | RSS: Main: 232120320 05:52:47 INFO - PROCESS | 1649 | 05:52:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 05:52:51 INFO - PROCESS | 1649 | RSS: Main: 328945664 05:52:51 INFO - PROCESS | 1649 | 05:52:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 05:52:53 INFO - PROCESS | 1649 | RSS: Main: 228552704 05:52:53 INFO - PROCESS | 1649 | 05:52:55 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:56 INFO - PROCESS | 1649 | RSS: Main: 230141952 05:52:56 INFO - PROCESS | 1649 | 05:52:59 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:59 INFO - PROCESS | 1649 | RSS: Main: 267087872 05:52:59 INFO - PROCESS | 1649 | 05:53:02 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 05:53:03 INFO - PROCESS | 1649 | RSS: Main: 267988992 05:53:03 INFO - PROCESS | 1649 | 05:53:06 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 05:53:06 INFO - PROCESS | 1649 | RSS: Main: 267464704 05:53:06 INFO - PROCESS | 1649 | 05:53:08 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:53:08 INFO - PROCESS | 1649 | RSS: Main: 243462144 05:53:08 INFO - PROCESS | 1649 | 05:53:10 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:53:11 INFO - PROCESS | 1649 | RSS: Main: 247808000 05:53:11 INFO - PROCESS | 1649 | 05:53:13 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:14 INFO - PROCESS | 1649 | RSS: Main: 254443520 05:53:14 INFO - PROCESS | 1649 | 05:53:16 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:53:17 INFO - PROCESS | 1649 | RSS: Main: 258695168 05:53:17 INFO - PROCESS | 1649 | 05:53:20 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:53:20 INFO - PROCESS | 1649 | RSS: Main: 259764224 05:53:20 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 05:53:22 INFO - PROCESS | 1649 | RSS: Main: 304005120 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | __start_tp_report 05:53:22 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 05:53:22 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 05:53:22 INFO - PROCESS | 1649 | |i|pagename|runs| 05:53:22 INFO - PROCESS | 1649 | |0;ai-astar;115;115;115;113;114;114;113;114;114;114 05:53:22 INFO - PROCESS | 1649 | |1;audio-beat-detection;143;106;107;141;111;107;108;105;137;105 05:53:22 INFO - PROCESS | 1649 | |2;audio-dft;183;184;180;183;186;184;183;184;183;183 05:53:22 INFO - PROCESS | 1649 | |3;audio-fft;80;59;58;86;59;57;57;58;79;57 05:53:22 INFO - PROCESS | 1649 | |4;audio-oscillator;84;70;93;68;67;68;91;68;68;89 05:53:22 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;91;87;90;88;86;110;91;88;84;123 05:53:22 INFO - PROCESS | 1649 | |6;imaging-darkroom;94;96;96;95;95;95;98;96;95;95 05:53:22 INFO - PROCESS | 1649 | |7;imaging-desaturate;85;85;85;85;86;85;87;86;86;84 05:53:22 INFO - PROCESS | 1649 | |8;json-parse-financial;55;56;53;55;57;58;57;58;57;56 05:53:22 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;63;71;77;75;71;67;67;67;67;68 05:53:22 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;85;83;79;83;82;81;86;85;80;106 05:53:22 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;159;153;141;136;132;142;135;131;144;133 05:53:22 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;163;163;161;161;162;159;161;160;159;204 05:53:22 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;65;65;64;66;63;66;65;65;63;65 05:53:22 INFO - PROCESS | 1649 | __end_tp_report 05:53:22 INFO - PROCESS | 1649 | __start_cc_report 05:53:22 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1868 05:53:22 INFO - PROCESS | 1649 | __end_cc_report 05:53:22 INFO - PROCESS | 1649 | __startTimestamp1483451602876__endTimestamp 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | ------- Summary: start ------- 05:53:22 INFO - PROCESS | 1649 | Number of tests: 14 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 05:53:22 INFO - PROCESS | 1649 | Values: 115.0 115.0 115.0 113.0 114.0 114.0 113.0 114.0 114.0 114.0 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:117.00 Median:109.50 stddev:16.25 (14.8%) stddev-sans-first:14.26 05:53:22 INFO - PROCESS | 1649 | Values: 143.0 106.0 107.0 141.0 111.0 107.0 108.0 105.0 137.0 105.0 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:1.49 (0.8%) stddev-sans-first:1.58 05:53:22 INFO - PROCESS | 1649 | Values: 183.0 184.0 180.0 183.0 186.0 184.0 183.0 184.0 183.0 183.0 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:65.00 Median:59.00 stddev:11.66 (19.8%) stddev-sans-first:11.03 05:53:22 INFO - PROCESS | 1649 | Values: 80.0 59.0 58.0 86.0 59.0 57.0 57.0 58.0 79.0 57.0 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:77.00 stddev:11.14 (14.5%) stddev-sans-first:11.49 05:53:22 INFO - PROCESS | 1649 | Values: 84.0 70.0 93.0 68.0 67.0 68.0 91.0 68.0 68.0 89.0 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:93.80 Median:88.00 stddev:12.54 (14.3%) stddev-sans-first:13.26 05:53:22 INFO - PROCESS | 1649 | Values: 91.0 87.0 90.0 88.0 86.0 110.0 91.0 88.0 84.0 123.0 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:95.50 Median:95.50 stddev:1.08 (1.1%) stddev-sans-first:1.00 05:53:22 INFO - PROCESS | 1649 | Values: 94.0 96.0 96.0 95.0 95.0 95.0 98.0 96.0 95.0 95.0 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.84 (1.0%) stddev-sans-first:0.88 05:53:22 INFO - PROCESS | 1649 | Values: 85.0 85.0 85.0 85.0 86.0 85.0 87.0 86.0 86.0 84.0 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:1.55 (2.7%) stddev-sans-first:1.58 05:53:22 INFO - PROCESS | 1649 | Values: 55.0 56.0 53.0 55.0 57.0 58.0 57.0 58.0 57.0 56.0 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:4.22 (6.1%) stddev-sans-first:3.81 05:53:22 INFO - PROCESS | 1649 | Values: 63.0 71.0 77.0 75.0 71.0 67.0 67.0 67.0 67.0 68.0 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:83.00 stddev:7.72 (9.3%) stddev-sans-first:8.19 05:53:22 INFO - PROCESS | 1649 | Values: 85.0 83.0 79.0 83.0 82.0 81.0 86.0 85.0 80.0 106.0 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:141.50 stddev:9.32 (6.6%) stddev-sans-first:7.13 05:53:22 INFO - PROCESS | 1649 | Values: 159.0 153.0 141.0 136.0 132.0 142.0 135.0 131.0 144.0 133.0 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:161.50 stddev:13.67 (8.5%) stddev-sans-first:14.48 05:53:22 INFO - PROCESS | 1649 | Values: 163.0 163.0 161.0 161.0 162.0 159.0 161.0 160.0 159.0 204.0 05:53:22 INFO - PROCESS | 1649 | 05:53:22 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 05:53:22 INFO - PROCESS | 1649 | Values: 65.0 65.0 64.0 66.0 63.0 66.0 65.0 65.0 63.0 65.0 05:53:22 INFO - PROCESS | 1649 | -------- Summary: end -------- 05:53:22 INFO - PROCESS | 1649 | 05:53:23 INFO - TEST-INFO | 1649: exit 0 05:53:23 INFO - TEST-OK | kraken | took 57141ms 05:53:23 INFO - SUITE-END | took 1172s 05:53:24 INFO - Completed test suite (00:19:33) 05:53:24 INFO - javascript benchmark 05:53:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3246.1722260823485, 3328.36761015407, 3482.7213822894173, 3486.7733597316155, 3541.0262177901072, 5705.286839145107, 5796.9710151449235, 5807.30312362516, 5824.359320474744, 5876.794312199074, 5696.458836410545, 5765.509931655814, 5845.766169353232, 5852.414758524145, 5852.941470585293, 5238.895222095556, 5307.52232299093, 5318.760655770499, 5326.786928522854, 5360.839174824761, 5300.575953923677, 5317.680939143664, 5326.573874090082, 5371.543418809406, 5377.516023557879, 5369.704666243355, 5381.48875856793, 5386.272853164812, 5390.110631745757, 5391.56867450603, 5298.152295632719, 5364.168553874156, 5365.222042803791, 5373.328333958255, 5381.67709937405, 5163.096458119814, 5238.711870847102, 5307.336582927134, 5308.495692909168, 5328.094223981893, 5941.524678025748, 5984.371640977722, 5999.190109335271, 6014.248218972629, 6021.36775638556, 6161.938380616226, 6223.284322302948, 6285.842853928642, 6293.559450838443, 6305.432511073979, 6130.581587307925, 6165.537584681167, 6259.029850373199, 6259.217597800275, 6266.4360207581085, 5254.474552544715, 5785.537157027427, 5874.102222310677, 5964.522838172936, 6016.338202797689, 6256.499480041586, 6349.904751428732, 6355.809325720235, 6373.139626150411, 6377.7767778127545, 6084.361142080106, 6154.630722156685, 6187.907181392283, 6193.102000209944, 6277.843053923597, 5116.641835071509, 5244.239585260192, 6359.586626869239, 6363.649999249993, 6367.4906007519285, 6145.692715364214, 6286.277078136073, 6307.369263073656, 6319.526035547352, 6324.335944725737, 6113.319832214623, 6205.937940620626, 6279.183706118175, 6295.118683384329, 6306.054091886253, 5020.322256495327, 5024.120778863684, 5028.823991160365, 5036.748162591855, 5041.6722913010535, 4418.889527761831, 4537.047220083753, 4539.296409056601, 4541.591256786839, 4549.067441174551, 5856.736446859902, 5879.235699359056, 5941.554383421174, 5952.255968003999, 5952.672603006876, 6239.750409983641, 6265.498760099181, 6341.619502829845, 6347.0479428086155, 6362.141110950055, 6014.9699251504335, 6027.065804800263, 6057.182280392179, 6065.181200537959, 6079.817605471843, 5442.319710036246, 5488.286522752017, 5496.7526461309335, 5511.035568775448, 5522.9447705523235, 6270.435660790551, 6290.874182516415, 6318.715657795318, 6403.103565500834, 6426.196725409324, 6293.433590976834, 6320.494360451245, 6352.587081839665, 6356.141920840627, 6363.5863668861375, 6358.713857876499, 6376.234851817811, 6397.0724244983285, 6422.582532135396, 6427.614343139427, 6142.560166306883, 6182.752689892533, 6207.193064901534, 6306.558540902093, 6308.873822523616, 5224.320838290998, 6248.500119990481, 6330.556861019869, 6355.046742988588, 6375.6174629522375, 6202.0, 6213.1922850029205, 6232.314445410911, 6245.250569931455, 6260.937390626218, 6042.1540984261355, 6093.512518998558, 6139.522803442411, 6226.470749986302, 6236.064590311489, 6055.364186760326, 6091.882314775641, 6139.062858969336, 6149.169862068742, 6160.537959652955, 6212.596181248205, 6219.0, 6225.408586184486, 6226.906596400967, 6242.937570624235, 5817.389174136655, 5932.614380065282, 6083.908741368795, 6095.573309868267, 6121.081837724377], "value": 5788.20256369094, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.63323140875764, 529.7483695244758, 543.3751186135945, 545.280230096273, 555.4029418375246, 27517.0, 32384.19039524013, 33724.494132588, 42123.57876421235, 43134.0, 43745.562544374545, 44024.55975440245, 44097.7795111024, 44221.77889110558, 44260.893477663, 9930.056644618768, 10114.747131321703, 10116.696499105039, 10119.696409107739, 10132.54403551842, 9218.58516366765, 9449.338546301762, 12194.207376520499, 12463.252204867737, 12471.189372690746, 12250.509979600805, 12306.20009699371, 12352.320622365767, 12352.44414001372, 12353.07351948603, 12198.634040978784, 12300.876991230063, 12311.630651080482, 12321.5071397144, 12325.568605098779, 12198.390080496029, 12255.75488490234, 12272.018238540895, 12274.018078553783, 12294.20087694297, 41855.581444185475, 42059.738207853814, 42060.57939420628, 42103.7894810524, 42139.0, 3516.8241587920757, 3613.259281847215, 3663.249033948034, 3730.794806285653, 4389.780510974439, 31801.363972720417, 32038.519422208687, 32145.6785432145, 32467.83766081178, 32589.511157332658, 3248.8953755722932, 3278.60656721195, 3348.0625424881073, 3374.0552645259368, 3379.662033796625, 540808.5919140797, 546904.0, 547559.0, 547768.0, 548737.2563137199, 53498.732506338, 63034.0, 63482.68258658677, 63514.36485635177, 63654.363456364845, 36552.63447365545, 37168.0, 37283.81358093192, 38479.422808657895, 66544.0, 17679.0, 17826.821731782777, 17839.286428542713, 17858.46424607264, 17894.731579026324, 12372.44324005422, 12591.811122833165, 13414.396352164176, 13594.11638243511, 13611.319434028457, 17524.47426577205, 17684.0, 17685.027323497332, 19422.116657658295, 20621.690674639893, 7817.374610031184, 7879.645415956295, 7915.762527124196, 7916.287534121957, 7966.482178658369, 911.6171208092617, 948.2603569216022, 963.4604621412032, 1006.3006210683504, 1059.06802014227, 31184.53223201654, 31251.84374078115, 31255.06234812959, 31557.21106972298, 31929.361412771614, 966.5312323523086, 967.4533888353058, 1082.3397727386289, 1094.5402930769096, 1103.6964834670368, 15349.386024558893, 15937.12345820991, 15969.920150399406, 16103.67792644164, 16241.187940603158, 718044.0, 722694.0, 723310.0, 724745.0, 726285.0, 60548.697256513435, 60955.08567371493, 61033.69483152556, 61195.0, 61603.38396616066, 1273.891719203878, 1316.822228999092, 1363.16165558181, 1410.1116296732991, 1427.0, 31106.22234444157, 32478.67521324851, 32786.836065819516, 32921.02473851576, 33545.329093418484, 51074.0, 51364.48635513597, 51519.96960060853, 51584.48415515797, 51789.0, 578265.0, 579379.2062079494, 579537.0, 580298.0, 580745.0, 24608.0, 25277.368065798502, 27186.592201116604, 27199.59200611953, 27700.584491232243, 47255.0, 48260.0, 48587.0, 49088.01823963572, 49144.262836056776, 30732.385352292382, 36254.8187259062, 37983.81008094942, 40551.0, 41094.38358424686, 40015.59984400119, 40573.985650358976, 41105.972350691474, 41272.0, 42079.36880946727, 39306.803465982484, 39904.60095399009, 40058.799706001286, 40265.0, 40313.395299071126, 33692.66307336895, 34912.650873491955, 35177.82411087928, 35706.821465892506, 35842.10394740048, 26079.739202607732, 26188.0, 26304.73695263023, 26382.73617263803, 26815.597766033916], "value": 20877.068674801372, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.6904734546653, 378.78787878787875, 391.11412650346966, 399.3231472653853, 405.53768703677815, 19464.610707785836, 21357.359279221608, 21965.121395144193, 22220.111195552177, 23171.420714482145, 20982.37052888412, 21344.57310853782, 21584.13663453464, 22127.668084978737, 22462.0, 5022.748862556876, 5580.888382232373, 6377.266614339341, 6417.197850268716, 6434.324395938429, 4015.538213105501, 4573.0, 6260.092286618437, 6399.328070552595, 6401.647909364983, 4576.084783043388, 7162.64186790661, 7239.638018099074, 7246.710131594757, 7269.6728647211, 7132.860141957418, 7160.928390716131, 7191.496595238335, 7193.856122877513, 7212.3148300911325, 6174.567780255384, 6245.313015568284, 6252.53106017046, 6254.6247225166635, 6256.843578910518, 27178.5923211152, 27727.86136069327, 27772.30569235765, 28133.43733125326, 28410.0, 2170.967435488469, 2251.887405629712, 2347.4483496378507, 2510.33476128826, 2796.2170592234206, 10481.63314284004, 10495.842562361571, 10527.578896844117, 10830.512626931806, 11060.612878549213, 1644.4326707285968, 1968.8129627685346, 1978.3669225847734, 1982.4250967219489, 1990.263602467082, 108314.0, 112192.0, 112883.0, 113836.0, 116092.18297164552, 11768.352740599177, 11908.404579770977, 11910.464029118537, 11969.760604787856, 12087.153899227145, 15175.924120379548, 15203.0, 15220.847791522165, 15237.923810380877, 15290.541283761506, 8808.339374546935, 9141.725748227564, 9175.58709858058, 9234.676786312446, 9288.0, 9118.726438206864, 9135.817283654289, 9144.8628270576, 9278.62885484573, 9306.348555601044, 4592.770361481913, 4661.230896902041, 4667.276572131325, 4739.644526660514, 4785.59322457595, 1873.9531511712044, 1919.64486569985, 1926.1524929031182, 1926.9325573605138, 1936.351322307043, 869.826034793044, 941.5339406993583, 969.7187815533557, 1024.9641262555924, 1037.3153718545875, 20358.0, 23085.653715194287, 23332.300030999097, 23354.18260360879, 23403.180888668816, 867.2940425871196, 943.2783920300975, 964.2334344196381, 967.351874244258, 981.4994352880083, 9759.853602195974, 11262.774744505228, 11936.448261726093, 11971.52113915451, 12022.398880055962, 575831.0, 646056.0, 650392.0, 661105.0, 668145.0, 89047.66428503577, 104540.47729761302, 119455.0, 139925.60074399126, 149204.0, 978.6379039755194, 1006.6476733143342, 1059.5708737961138, 1060.5068643081004, 1064.1965316186383, 19247.807521925162, 20941.891264983587, 21004.47488812792, 21184.0, 21256.36230913013, 53441.732791335795, 53592.19611705906, 57642.42357576371, 58391.0, 58473.24580262599, 83342.16657833345, 86014.56992714996, 86046.0, 86217.0, 86802.56598716966, 8312.87530687028, 8436.915630843612, 8637.0, 8706.259967902799, 8788.868166977372, 11907.166498345032, 13262.602121936357, 13461.192328460324, 13633.931830340785, 13743.244121573409, 9820.067093626094, 11399.95301667896, 11592.072634189077, 11757.353345565734, 11932.403379831147, 10506.159507239556, 10748.677539673823, 11391.943040284745, 11457.484413201593, 11673.766524669629, 11436.599719010128, 11801.992750034624, 12054.819177712518, 12106.092043096627, 12208.81686774717, 8485.066642669424, 8647.740567782977, 8678.392512524062, 8708.651653934025, 8782.429142105742, 10108.646197383056, 11678.124140689313, 11701.88298117008, 11792.174547781917, 11976.041916646473], "value": 10057.355594037626, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1542.275130688576, 1556.4085647453967, 1756.9209385577649, 1892.3944337811906, 1898.0320036781245, 8562.957185214073, 9077.455352678844, 9077.591508382122, 9093.227075698573, 9100.544972751353, 7877.4485785995, 8145.389095817808, 8159.877601835978, 8256.215659512352, 8855.203031727144, 2163.891805409731, 2209.856359336646, 2304.850184737995, 2373.2998765364173, 2384.6661467394492, 2384.3204686664303, 2386.570417324881, 2388.4028992751814, 2389.175734371639, 2393.3777217923293, 2352.541254455382, 2414.239514552919, 2415.661807346964, 2415.915442959497, 2416.2388847512975, 2154.84715677112, 2365.9763402366016, 2379.1078345620394, 2399.0883464283634, 2399.3401814500976, 2284.12061356379, 2312.976870231293, 2365.9645105323434, 2381.8094552435764, 2397.2448678666165, 8826.0, 9019.331423686639, 9037.0, 9040.321975851837, 9040.728778136667, 5345.866353341197, 5516.255305533782, 5520.923419933115, 5527.53015993641, 5535.225068490415, 3516.3670539302916, 3619.7466177367596, 3686.4286035664513, 3699.3711069118312, 3701.3152566775234, 1053.6628278950739, 1092.5848177692505, 1118.9384583847884, 1121.938293393863, 1123.039800970175, 11761.411929403495, 11796.29222246668, 11796.646100616996, 11801.350925699084, 11804.0, 4769.213079841857, 4797.520247975174, 4869.366982292279, 4914.017196560702, 4948.158813001798, 10137.239707022003, 10137.98620137995, 10138.898611013943, 10142.239332050125, 10146.797064058677, 5524.779008839601, 5525.336959564878, 5525.806596769094, 5530.557555395559, 5532.806351777668, 4517.841875534341, 4885.071836351153, 4983.352164218701, 5081.085404627129, 5086.669366491166, 3174.698403651649, 3911.3741801311653, 3981.482407287034, 4094.201630682048, 4097.795110244536, 1282.8588855225917, 1296.883280504759, 1297.8896793772446, 1311.7442098790834, 1315.8684131586765, 773.7137259214014, 882.342654722236, 912.2519533982071, 915.4644532948166, 919.9788235059079, 5818.127280907897, 5820.0, 5905.40945905406, 5934.821955341346, 6145.723442445101, 914.291424146292, 978.9706308810747, 983.6360546597805, 995.6913356859396, 1036.404067661098, 3432.742544309137, 3953.9011524711536, 4067.877963661095, 4079.755214687128, 4118.135191609796, 10437.165026797838, 10797.514111864984, 10855.782884342427, 10982.395968221665, 11039.889601103887, 10895.237333386745, 10924.781504369868, 10932.344059356465, 10947.124230061576, 10955.50700218492, 8303.584820758937, 8553.059163492011, 8553.57232138403, 8559.614817333235, 8579.828403431897, 5614.129809879475, 5859.531237501075, 5932.851678707894, 6141.140240366263, 6173.84565385869, 9547.379420337656, 10063.899361006297, 10233.48832558384, 10315.0, 10332.896671033493, 10389.480525973822, 10395.168386528909, 10399.1160751337, 10405.0, 10407.84388234162, 6097.481714054177, 7674.347680447225, 7817.5309481431295, 7830.8825367620675, 8076.757697269091, 7703.345215656732, 7993.080795708568, 8339.583020848811, 8472.83054338922, 8624.353173512138, 7518.473706840688, 7573.129090154703, 7646.006019217466, 7672.38620910337, 7720.8455830884195, 7407.962960185165, 7433.516821406592, 7457.179710231979, 7465.4027677786735, 7533.773986780406, 6854.588724676535, 6979.616121113185, 7030.437564994891, 7127.928720712726, 7135.429165666838, 4926.5073492650445, 5006.899862002812, 5026.648134630541, 5053.797848086036, 5064.442911279682, 4884.291777692144, 4913.729744864067, 4930.7534623267975, 4976.552110310089, 5080.034793389244], "value": 4657.17857818162, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [257.3104081062752, 299.31606279651004, 311.56847765844304, 317.87126213883386, 321.6188816252739, 4472.741265660845, 5276.512427075846, 5276.525112739852, 5353.304070470838, 5382.761964748111, 4022.4770779798587, 4251.574842515747, 4630.699004564701, 5089.676684062152, 5209.843704688856, 4044.029432936089, 4068.8982775430554, 4092.774897380643, 4095.7747323897174, 4100.466939297902, 4089.407035979781, 4096.713230073896, 4099.221147981889, 4102.7128101032795, 4128.669706423494, 3923.3722604383306, 4051.331530297512, 4076.5311989121187, 4077.5922407759285, 4084.2035803018425, 3795.35478968576, 3813.561440434344, 3997.2405243003736, 4052.959470405288, 4053.1893621275567, 3543.362194804934, 3544.131687736521, 3564.4475106358555, 3567.8037707926055, 3571.910702232439, 3995.122292522539, 4537.523560026183, 5093.376910890857, 5128.333316668809, 5153.433122356538, 3927.5483319418345, 4348.934765978513, 4557.903364452356, 4619.8219454039345, 4628.745419001953, 4929.901401971941, 5215.895682086375, 5516.531094856942, 5522.282103326582, 5527.778888844441, 3872.9031774205587, 3873.1672690371706, 3886.9116647338506, 3900.258950799339, 3920.764754114762, 5187.714675692835, 5463.562914966793, 5657.1514272858985, 5747.3103227612955, 5827.446392592697, 3233.3694929488524, 3256.5929258842643, 3799.4490798834568, 3834.827432765532, 3839.2897313997, 3996.5603783583783, 4009.3585026395635, 4026.657734092635, 4027.3958906163725, 4085.816138273785, 3929.7011248419994, 3957.920841583152, 4628.190066738307, 4669.439667239885, 4678.8128474861305, 4207.389928460356, 5501.257330260363, 5507.421720719267, 5520.530754885799, 5602.551795856321, 1342.02703040295, 1361.686812033218, 1365.3582816076428, 1370.0341259412091, 1379.0140049864394, 885.93798434109, 926.2682480840061, 940.6378544260509, 948.4025064209504, 949.1457688080644, 4469.932951005738, 5285.524302812689, 5286.515337791232, 5321.308229930084, 5344.545713614309, 5644.887102258014, 5660.801871934463, 5683.516901063456, 5685.3177618685195, 5688.984838035765, 4928.359313289249, 5045.722485263345, 5310.495502927216, 5314.256004159421, 5319.707416092075, 2206.4594174427366, 2247.797698207169, 2480.2931164618, 2516.6476693262957, 2520.1099175618288, 4337.900683853728, 4602.516735742765, 4900.8774780630765, 4934.55588996992, 5023.372078490189, 4371.819608705695, 4487.833163377545, 4818.6626936114135, 4853.563179313808, 4958.157427993334, 4202.978985105116, 4818.698951283134, 4894.706317620954, 4933.506649335038, 4955.653104282737, 3932.941005884971, 4420.170836058233, 4602.182138055382, 4699.882502937454, 4730.526947305242, 4661.270983213483, 4691.451820899163, 4724.244120940633, 5124.871878203075, 5771.653700777967, 5694.829155125353, 5906.320773110975, 6040.909386359121, 6055.666938318259, 6055.878882422238, 3812.199438117915, 3814.8664796731982, 3839.5584507781964, 3852.6725228355904, 3852.807359631951, 5577.721113944205, 5781.884362312814, 5797.130430435468, 5823.708814559171, 5840.532757379315, 4849.296851956376, 5178.6374953752875, 5603.327600687943, 5689.288838895138, 5694.174344720075, 5607.271054762855, 5608.7099967008635, 5611.482756381152, 5631.0, 5649.519790817662, 5506.614536982533, 5513.917291240715, 5521.944780552143, 5541.5289700375915, 5542.976813463138, 4862.95137048625, 5000.199968005102, 5134.075866344094, 5626.0, 5660.462256085665, 4397.494288156903, 4573.588377046081, 5218.6868787872845, 5489.945100548944, 5506.449355064622], "value": 3969.4119336126623, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.8875379939211, 777.3198451355064, 779.1468342165327, 784.9999999999999, 840.2102024097352, 15812.525624231277, 17007.659846803057, 17026.0, 17059.829401705978, 17065.14674266288, 15247.0, 15358.308876100575, 15358.462453814118, 15360.61598460039, 15366.0, 718.4216705552028, 731.5829976913161, 875.8248350329943, 887.1970866365917, 902.9774255643596, 875.916787905148, 893.865920111982, 894.8568229083348, 895.0601868038566, 895.7850115972152, 945.8675785390051, 946.9242460603135, 947.3794664494767, 949.7245798718363, 949.9287553433486, 942.8208640358345, 943.2265542255353, 943.8065196634674, 943.9811203775886, 946.394307643109, 699.9090118284641, 700.0269625220897, 700.8563244534859, 701.1586096683949, 701.5650296815955, 15504.689906201813, 15534.844651553565, 15537.766933496006, 15574.299156537983, 15593.532194034196, 13853.238071906042, 13855.722885542233, 14058.437662493488, 14139.363728632236, 14179.36192871313, 12783.680407989874, 12791.976641868721, 13564.525241616595, 13745.793813092812, 14429.35067921946, 4656.557627025427, 4691.483936766987, 4718.0328032753205, 4756.500567440438, 4913.06651736169, 119616.40191799072, 120900.0, 121640.0, 121708.39145804303, 126308.63222310036, 11470.0, 11569.363684997237, 11696.0, 11716.414179291001, 11817.822732659017, 23368.76631233666, 23526.64710029351, 23924.52150956971, 24048.15831445926, 24345.75654243435, 7181.856362872713, 8448.0, 8479.109693482218, 8697.826043479095, 8816.823663526693, 4343.1747967886, 4345.9348109778375, 4613.677042606985, 4705.858894023438, 4926.679765815211, 3704.6110158432975, 3797.1456422305314, 3814.427835824593, 3845.8461661533224, 3846.8845934622004, 603.2188316130621, 668.3850857211377, 693.9028536004963, 698.12734082397, 705.3898377903076, 510.8416390918827, 548.6625725179066, 668.1514476614672, 695.8330000799772, 712.9144502659714, 9234.0, 9791.51042447889, 10057.647982320585, 10160.593576257015, 10186.490675466197, 623.6227082615044, 670.76858483823, 693.8979544363436, 703.4969996452561, 732.4177279063158, 4750.009991606998, 4950.5489340438, 4977.776000080005, 5012.8496145115705, 5203.739813009334, 165038.0, 166093.0, 168619.0, 169463.81702287213, 170850.2914970859, 106140.0, 120920.0, 129320.0, 138831.0, 138846.3057684705, 122798.0, 127750.36124819316, 127891.72108278798, 128359.0, 130705.0, 9888.555015024198, 10209.132223761064, 10229.48852557384, 10271.281010329205, 10277.331973421704, 69023.65488172729, 69461.65269173622, 69757.30242697507, 70682.64658676674, 72609.6369518149, 102408.0, 105164.94835051552, 108088.4595577017, 109094.0, 111668.41657917234, 13299.154113902037, 13604.04771665974, 13618.863811362156, 13914.02601817863, 14064.226467544384, 15365.846341536888, 15953.282102305191, 16250.3499860009, 16832.57918552046, 16873.662526749642, 14933.925330373278, 14956.0, 15097.924510377377, 15563.221838907783, 15610.843891561393, 14244.145351278956, 14393.64015899569, 14397.120575885074, 14530.346134423766, 14762.114273143647, 13798.241096739373, 13985.58043258704, 14165.504207352693, 14525.571305458992, 14692.485762998243, 11114.277571957797, 12129.575464858688, 12248.571300004458, 12250.632481025583, 12268.386580670753, 11717.531298747954, 11859.22915010556, 12066.155369124077, 12159.452824622736, 12169.391530423267], "value": 8402.976610819864, "unit": "score"}], "name": "dromaeo_css", "value": 7574.223163456416, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 106.0, 107.0, 141.0, 111.0, 107.0, 108.0, 105.0, 137.0, 105.0], "value": 117.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 180.0, 183.0, 186.0, 184.0, 183.0, 184.0, 183.0, 183.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 86.0, 59.0, 57.0, 57.0, 58.0, 79.0, 57.0], "value": 65.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 93.0, 68.0, 67.0, 68.0, 91.0, 68.0, 68.0, 89.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 90.0, 88.0, 86.0, 110.0, 91.0, 88.0, 84.0, 123.0], "value": 93.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 96.0, 95.0, 95.0, 95.0, 98.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 87.0, 86.0, 86.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 53.0, 55.0, 57.0, 58.0, 57.0, 58.0, 57.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 77.0, 75.0, 71.0, 67.0, 67.0, 67.0, 67.0, 68.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 79.0, 83.0, 82.0, 81.0, 86.0, 85.0, 80.0, 106.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 153.0, 141.0, 136.0, 132.0, 142.0, 135.0, 131.0, 144.0, 133.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 161.0, 162.0, 159.0, 161.0, 160.0, 159.0, 204.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 66.0, 63.0, 66.0, 65.0, 65.0, 63.0, 65.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1411.7999999999997, "alertThreshold": 2.0}]} 05:53:24 INFO - Return code: 0 05:53:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:53:24 INFO - # TBPL SUCCESS # 05:53:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:24 INFO - 2017-01-03 05:53:24.204 screenresolution[1653:10243] starting screenresolution argv=screenresolution get 05:53:24 INFO - 2017-01-03 05:53:24.207 screenresolution[1653:10243] Display 0: 1600x1200x32@60 05:53:24 INFO - 2017-01-03 05:53:24.213 screenresolution[1654:10247] starting screenresolution argv=screenresolution list 05:53:24 INFO - Available Modes on Display 0 05:53:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:24 INFO - Intel Iris: 05:53:24 INFO - Chipset Model: Intel Iris 05:53:24 INFO - Type: GPU 05:53:24 INFO - Bus: Built-In 05:53:24 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:24 INFO - Vendor: Intel (0x8086) 05:53:24 INFO - Device ID: 0x0a2e 05:53:24 INFO - Revision ID: 0x0009 05:53:24 INFO - Displays: 05:53:24 INFO - Display: 05:53:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:24 INFO - Display Serial Number: 1600x1200 60 05:53:24 INFO - Main Display: Yes 05:53:24 INFO - Mirror: Off 05:53:24 INFO - Online: Yes 05:53:24 INFO - Rotation: Supported 05:53:24 INFO - Return code: 0 05:53:24 INFO - Running post-action listener: _resource_record_post_action 05:53:24 INFO - [mozharness: 2017-01-03 13:53:24.450834Z] Finished run-tests step (success) 05:53:24 INFO - Running post-run listener: _resource_record_post_run 05:53:24 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 33561600; Write bytes: 496975360; Read time: 334; Write time: 1613 05:53:24 INFO - TinderboxPrint: CPU usage
53.6% 05:53:24 INFO - TinderboxPrint: I/O read bytes / time
33,561,600 / 334 05:53:24 INFO - TinderboxPrint: I/O write bytes / time
496,975,360 / 1,613 05:53:24 INFO - TinderboxPrint: CPU idle
2,220.5 (46.4%) 05:53:24 INFO - TinderboxPrint: CPU system
963.2 (20.1%) 05:53:24 INFO - TinderboxPrint: CPU user
1,602.0 (33.5%) 05:53:24 INFO - TinderboxPrint: Swap in / out
224,690,176 / 0 05:53:24 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 187400704; Write bytes: 187893248; Read time: 17710; Write time: 386 05:53:24 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 32627712; Write bytes: 298960896; Read time: 298; Write time: 1195 05:53:24 INFO - Running post-run listener: _upload_blobber_files 05:53:24 INFO - Blob upload gear active. 05:53:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:24 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 05:53:24 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'] 05:53:24 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 05:53:25 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:53:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:53:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:26 INFO - (blobuploader) - INFO - Done attempting. 05:53:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:53:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:53:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:27 INFO - (blobuploader) - INFO - Done attempting. 05:53:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:53:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:53:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:29 INFO - (blobuploader) - INFO - Done attempting. 05:53:29 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:29 INFO - Return code: 0 05:53:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5314b45157aaf2aaeffe596358d79964211758848f4caa18bb4cb270ee834e435619e6c2547c35aea8d85480a5be281a759e42a2455899a5f70b4d0d50832c93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cdcde9fa8269f032e4593b76aed634b864daff5fc5042ff90dfae431f0c50ed7f19ad7fb59cb3b39b8c0278cd9cbd4396cb8f7e81435f26b225d7450693dccc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a387573be12b82bc28bbec3beed1958aae0cda4ef82f8bfce3392cfa6350912d39134a63d66f3c056cbc4487e573bb718d647e0a0a8064d3a1519a4b63acd79"} 05:53:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:29 INFO - Contents: 05:53:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5314b45157aaf2aaeffe596358d79964211758848f4caa18bb4cb270ee834e435619e6c2547c35aea8d85480a5be281a759e42a2455899a5f70b4d0d50832c93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cdcde9fa8269f032e4593b76aed634b864daff5fc5042ff90dfae431f0c50ed7f19ad7fb59cb3b39b8c0278cd9cbd4396cb8f7e81435f26b225d7450693dccc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a387573be12b82bc28bbec3beed1958aae0cda4ef82f8bfce3392cfa6350912d39134a63d66f3c056cbc4487e573bb718d647e0a0a8064d3a1519a4b63acd79"} 05:53:29 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:29 INFO - Copying logs to upload dir... 05:53:29 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.976055 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-03 05:53:29.657192) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 05:53:29.660788) ========= 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.I2durOYlWF/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.tq4NTUJgHm/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5314b45157aaf2aaeffe596358d79964211758848f4caa18bb4cb270ee834e435619e6c2547c35aea8d85480a5be281a759e42a2455899a5f70b4d0d50832c93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cdcde9fa8269f032e4593b76aed634b864daff5fc5042ff90dfae431f0c50ed7f19ad7fb59cb3b39b8c0278cd9cbd4396cb8f7e81435f26b225d7450693dccc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a387573be12b82bc28bbec3beed1958aae0cda4ef82f8bfce3392cfa6350912d39134a63d66f3c056cbc4487e573bb718d647e0a0a8064d3a1519a4b63acd79"} build_url:https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/OjU5krD7RSiiJsRTdSQ5vw/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5314b45157aaf2aaeffe596358d79964211758848f4caa18bb4cb270ee834e435619e6c2547c35aea8d85480a5be281a759e42a2455899a5f70b4d0d50832c93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cdcde9fa8269f032e4593b76aed634b864daff5fc5042ff90dfae431f0c50ed7f19ad7fb59cb3b39b8c0278cd9cbd4396cb8f7e81435f26b225d7450693dccc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a387573be12b82bc28bbec3beed1958aae0cda4ef82f8bfce3392cfa6350912d39134a63d66f3c056cbc4487e573bb718d647e0a0a8064d3a1519a4b63acd79"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 05:53:29.694363) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 05:53:29.694691) ========= 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.I2durOYlWF/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.tq4NTUJgHm/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.005214 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 05:53:29.743378) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 05:53:29.743695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 05:53:29.744055) ========= ========= Total master_lag: 0.18 =========