builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0098 starttime: 1488591819.06 results: success (0) buildid: 20170303162023 builduid: 1bdd524be485483baf6a814fec7890db revision: e11b1a808700d7428c6ce94ca22921ae000424c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:39.059661) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:39.060094) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:39.060368) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:39.085657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:39.086024) ========= 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.SjjlJhW6fq/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.fAjwm7NhbL/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-03-03 17:43:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2017-03-03 17:43:39 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117970 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:39.227534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:39.227857) ========= 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.SjjlJhW6fq/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.fAjwm7NhbL/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.022161 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:39.276482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 17:43:39.276842) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e11b1a808700d7428c6ce94ca22921ae000424c1 --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-aurora --rev e11b1a808700d7428c6ce94ca22921ae000424c1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SjjlJhW6fq/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.fAjwm7NhbL/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-03-03 17:43:39,560 truncating revision to first 12 chars 2017-03-03 17:43:39,561 Setting DEBUG logging. 2017-03-03 17:43:39,561 attempt 1/10 2017-03-03 17:43:39,561 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e11b1a808700?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-03 17:43:40,352 unpacking tar archive at: mozilla-aurora-e11b1a808700/testing/mozharness/ program finished with exit code 0 elapsedTime=1.035313 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 17:43:40.336567) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:40.336971) ========= script_repo_revision: e11b1a808700d7428c6ce94ca22921ae000424c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:40.337435) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:40.337718) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:40.358246) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-03 17:43:40.358664) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SjjlJhW6fq/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.fAjwm7NhbL/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 17:43:40 INFO - MultiFileLogger online at 20170303 17:43:40 in /builds/slave/test 17:43:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:43:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:43:40 INFO - {'append_to_log': False, 17:43:40 INFO - 'base_work_dir': '/builds/slave/test', 17:43:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:43:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:43:40 INFO - 'branch': 'Mozilla-Aurora', 17:43:40 INFO - 'buildbot_json_path': 'buildprops.json', 17:43:40 INFO - 'config_files': ('talos/mac_config.py',), 17:43:40 INFO - 'default_actions': ('clobber', 17:43:40 INFO - 'read-buildbot-config', 17:43:40 INFO - 'download-and-extract', 17:43:40 INFO - 'populate-webroot', 17:43:40 INFO - 'create-virtualenv', 17:43:40 INFO - 'install', 17:43:40 INFO - 'run-tests'), 17:43:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:43:40 INFO - 'download_minidump_stackwalk': True, 17:43:40 INFO - 'download_symbols': 'ondemand', 17:43:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:43:40 INFO - 'tooltool.py': '/tools/tooltool.py', 17:43:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:43:40 INFO - '/tools/misc-python/virtualenv.py')}, 17:43:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:43:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:43:40 INFO - 'installer_path': 'installer.exe', 17:43:40 INFO - 'log_level': 'info', 17:43:40 INFO - 'log_name': 'talos', 17:43:40 INFO - 'log_to_console': True, 17:43:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:43:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:43:40 INFO - 'opt_config_files': (), 17:43:40 INFO - 'pip_index': False, 17:43:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:43:40 INFO - 'cmd': ('bash', 17:43:40 INFO - '-c', 17:43:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:43:40 INFO - 'enabled': True, 17:43:40 INFO - 'halt_on_failure': False, 17:43:40 INFO - 'name': 'check_screen_resolution'},), 17:43:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:43:40 INFO - 'cmd': ('bash', 17:43:40 INFO - '-c', 17:43:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:43:40 INFO - 'enabled': True, 17:43:40 INFO - 'halt_on_failure': False, 17:43:40 INFO - 'name': 'check_screen_resolution'},), 17:43:40 INFO - 'run_cmd_checks_enabled': True, 17:43:40 INFO - 'sps_profile': False, 17:43:40 INFO - 'sps_profile_interval': 0, 17:43:40 INFO - 'suite': 'dromaeojs', 17:43:40 INFO - 'system_bits': '32', 17:43:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:43:40 INFO - 'title': 't-yosemite-r7-0098', 17:43:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:43:40 INFO - 'use_talos_json': True, 17:43:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:43:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:43:40 INFO - 'work_dir': 'build'} 17:43:40 INFO - [mozharness: 2017-03-04 01:43:40.765378Z] Running clobber step. 17:43:40 INFO - Running pre-action listener: _resource_record_pre_action 17:43:40 INFO - Running main action method: clobber 17:43:40 INFO - rmtree: /builds/slave/test/build 17:43:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:43:42 INFO - Running post-action listener: _resource_record_post_action 17:43:42 INFO - [mozharness: 2017-03-04 01:43:42.944362Z] Finished clobber step (success) 17:43:42 INFO - [mozharness: 2017-03-04 01:43:42.944520Z] Running read-buildbot-config step. 17:43:42 INFO - Running pre-action listener: _resource_record_pre_action 17:43:42 INFO - Running main action method: read_buildbot_config 17:43:42 INFO - Using buildbot properties: 17:43:42 INFO - { 17:43:42 INFO - "project": "", 17:43:42 INFO - "product": "firefox", 17:43:42 INFO - "script_repo_revision": "production", 17:43:42 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 17:43:42 INFO - "repository": "", 17:43:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 17:43:42 INFO - "buildid": "20170303162023", 17:43:42 INFO - "pgo_build": "False", 17:43:42 INFO - "basedir": "/builds/slave/test", 17:43:42 INFO - "buildnumber": 47, 17:43:42 INFO - "slavename": "t-yosemite-r7-0098", 17:43:42 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:43:42 INFO - "platform": "yosemite_r7", 17:43:42 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 17:43:42 INFO - "branch": "mozilla-aurora", 17:43:42 INFO - "repo_path": "releases/mozilla-aurora", 17:43:42 INFO - "revision": "e11b1a808700d7428c6ce94ca22921ae000424c1", 17:43:42 INFO - "stage_platform": "macosx64", 17:43:42 INFO - "builduid": "1bdd524be485483baf6a814fec7890db", 17:43:42 INFO - "slavebuilddir": "test" 17:43:42 INFO - } 17:43:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 17:43:42 INFO - Running post-action listener: _resource_record_post_action 17:43:42 INFO - [mozharness: 2017-03-04 01:43:42.947791Z] Finished read-buildbot-config step (success) 17:43:42 INFO - [mozharness: 2017-03-04 01:43:42.947886Z] Running download-and-extract step. 17:43:42 INFO - Running pre-action listener: _resource_record_pre_action 17:43:42 INFO - Running main action method: download_and_extract 17:43:42 INFO - mkdir: /builds/slave/test/build/tests 17:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:42 INFO - trying https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 17:43:42 INFO - Downloading https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 17:43:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 17:43:43 INFO - Downloaded 1199 bytes. 17:43:43 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 17:43:43 INFO - Using the following test package requirements: 17:43:43 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 17:43:43 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:43 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 17:43:43 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:43 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 17:43:43 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:43 INFO - u'jsshell-mac.zip'], 17:43:43 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:43 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 17:43:43 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 17:43:43 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:43 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 17:43:43 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:43 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 17:43:43 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:43 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 17:43:43 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:43 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 17:43:43 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 17:43:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 17:43:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:43:43 INFO - Fetch https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 17:43:44 INFO - Expected file size: 16357703 17:43:44 INFO - Obtained file size: 16357703 17:43:51 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 17:43:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 17:43:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:43:51 INFO - Fetch https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 17:43:52 INFO - Expected file size: 16357703 17:43:52 INFO - Obtained file size: 16357703 17:43:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 17:43:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 17:43:58 INFO - Fetch https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 17:44:00 INFO - Expected file size: 14403650 17:44:00 INFO - Obtained file size: 14403650 17:44: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')]} 17:44:00 INFO - trying https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 17:44:00 INFO - Downloading https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 17:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 17:44:02 INFO - Downloaded 73931039 bytes. 17:44:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 17:44:02 INFO - mkdir: /builds/slave/test/properties 17:44:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:44:02 INFO - Writing to file /builds/slave/test/properties/build_url 17:44:02 INFO - Contents: 17:44:02 INFO - build_url:https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 17:44:03 INFO - Running post-action listener: _resource_record_post_action 17:44:03 INFO - Running post-action listener: set_extra_try_arguments 17:44:03 INFO - [mozharness: 2017-03-04 01:44:03.497994Z] Finished download-and-extract step (success) 17:44:03 INFO - [mozharness: 2017-03-04 01:44:03.498139Z] Running populate-webroot step. 17:44:03 INFO - Running pre-action listener: _resource_record_pre_action 17:44:03 INFO - Running main action method: populate_webroot 17:44:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:44:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:44:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:44:03 INFO - '--tppagecycles', 17:44:03 INFO - '7'], 17:44:03 INFO - 'tests': ['tsvgm']}}, 17:44:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:44:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:44:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:44:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:44:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:44:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:44:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:44:03 INFO - 'talos_options': ['--disable-e10s'], 17:44:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:44:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:44:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:44:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:44:03 INFO - 'talos_options': ['--disable-e10s'], 17:44:03 INFO - 'tests': ['damp', 'tps']}, 17:44:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:44:03 INFO - 'tests': ['damp', 'tps']}, 17:44:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:44:03 INFO - 'tests': ['dromaeo_dom']}, 17:44:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:44:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:44:03 INFO - 'tests': ['basic_compositor_video']}, 17:44:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:44:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:44:03 INFO - 'tests': ['a11yr', 17:44:03 INFO - 'ts_paint', 17:44:03 INFO - 'tpaint', 17:44:03 INFO - 'sessionrestore', 17:44:03 INFO - 'sessionrestore_no_auto_restore', 17:44:03 INFO - 'tabpaint']}, 17:44:03 INFO - 'other-e10s': {'tests': ['a11yr', 17:44:03 INFO - 'ts_paint', 17:44:03 INFO - 'tpaint', 17:44:03 INFO - 'sessionrestore', 17:44:03 INFO - 'sessionrestore_no_auto_restore', 17:44:03 INFO - 'tabpaint']}, 17:44:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:44:03 INFO - 'ts_paint', 17:44:03 INFO - 'tpaint', 17:44:03 INFO - 'sessionrestore', 17:44:03 INFO - 'sessionrestore_no_auto_restore', 17:44:03 INFO - 'tabpaint']}, 17:44:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:44:03 INFO - 'ts_paint', 17:44:03 INFO - 'tpaint', 17:44:03 INFO - 'sessionrestore', 17:44:03 INFO - 'sessionrestore_no_auto_restore', 17:44:03 INFO - 'tabpaint']}, 17:44:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:44:03 INFO - 'tests': ['a11yr', 17:44:03 INFO - 'ts_paint', 17:44:03 INFO - 'tpaint', 17:44:03 INFO - 'sessionrestore', 17:44:03 INFO - 'sessionrestore_no_auto_restore', 17:44:03 INFO - 'tabpaint']}, 17:44:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:44:03 INFO - 'tests': ['a11yr', 17:44:03 INFO - 'ts_paint', 17:44:03 INFO - 'tpaint', 17:44:03 INFO - 'sessionrestore', 17:44:03 INFO - 'sessionrestore_no_auto_restore', 17:44:03 INFO - 'tabpaint']}, 17:44:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:44:03 INFO - 'tests': ['tsvgx', 17:44:03 INFO - 'tsvgr_opacity', 17:44:03 INFO - 'tart', 17:44:03 INFO - 'tscrollx', 17:44:03 INFO - 'cart', 17:44:03 INFO - 'tsvg_static']}, 17:44:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:44:03 INFO - 'tsvgr_opacity', 17:44:03 INFO - 'tart', 17:44:03 INFO - 'tscrollx', 17:44:03 INFO - 'cart', 17:44:03 INFO - 'tsvg_static']}, 17:44:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:44:03 INFO - 'talos_options': ['--disable-e10s'], 17:44:03 INFO - 'tests': ['tp5o']}, 17:44:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:44:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:44:03 INFO - 'talos_options': ['--disable-e10s', 17:44:03 INFO - '--xperf_path', 17:44:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:44:03 INFO - 'tests': ['tp5n']}, 17:44:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:44:03 INFO - 'talos_options': ['--xperf_path', 17:44:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:44:03 INFO - 'tests': ['tp5n']}}, 17:44:03 INFO - 'talos.zip': {'path': '', 17:44:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:44:03 INFO - Running post-action listener: _resource_record_post_action 17:44:03 INFO - [mozharness: 2017-03-04 01:44:03.516673Z] Finished populate-webroot step (success) 17:44:03 INFO - [mozharness: 2017-03-04 01:44:03.516768Z] Running create-virtualenv step. 17:44:03 INFO - Running pre-action listener: _resource_record_pre_action 17:44:03 INFO - Running main action method: create_virtualenv 17:44:03 INFO - Creating virtualenv /builds/slave/test/build/venv 17:44:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:44:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:44:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:44:03 INFO - Using real prefix '/tools/python27' 17:44:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:44:04 INFO - Installing distribute.............................................................................................................................................................................................done. 17:44:07 INFO - Installing pip.................done. 17:44:07 INFO - Return code: 0 17:44:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:44:07 INFO - Reading from file tmpfile_stdout 17:44:07 INFO - Output received: 17:44:07 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:44:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:07 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 0x10bcadb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcb0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb314b6200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8bd30>, '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 0x10b9b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba80be8>, '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.SjjlJhW6fq/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.fAjwm7NhbL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 17:44:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:44:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjjlJhW6fq/Render', 17:44:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:07 INFO - 'HOME': '/Users/cltbld', 17:44:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:07 INFO - 'LOGNAME': 'cltbld', 17:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:07 INFO - 'MOZ_NO_REMOTE': '1', 17:44:07 INFO - 'NO_EM_RESTART': '1', 17:44:07 INFO - 'PAGER': '/bin/cat', 17:44:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:07 INFO - 'PWD': '/builds/slave/test', 17:44:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:07 INFO - 'SHELL': '/bin/bash', 17:44:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fAjwm7NhbL/Listeners', 17:44:07 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 17:44:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:07 INFO - 'USER': 'cltbld', 17:44:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:07 INFO - 'XPC_FLAGS': '0x0', 17:44:07 INFO - 'XPC_SERVICE_NAME': '0', 17:44:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:44:07 INFO - Cleaning up... 17:44:07 INFO - Return code: 0 17:44:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:07 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 0x10bcadb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcb0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb314b6200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8bd30>, '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 0x10b9b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba80be8>, '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.SjjlJhW6fq/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.fAjwm7NhbL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 17:44:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:44:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjjlJhW6fq/Render', 17:44:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:07 INFO - 'HOME': '/Users/cltbld', 17:44:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:07 INFO - 'LOGNAME': 'cltbld', 17:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:07 INFO - 'MOZ_NO_REMOTE': '1', 17:44:07 INFO - 'NO_EM_RESTART': '1', 17:44:07 INFO - 'PAGER': '/bin/cat', 17:44:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:07 INFO - 'PWD': '/builds/slave/test', 17:44:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:07 INFO - 'SHELL': '/bin/bash', 17:44:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fAjwm7NhbL/Listeners', 17:44:07 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 17:44:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:07 INFO - 'USER': 'cltbld', 17:44:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:07 INFO - 'XPC_FLAGS': '0x0', 17:44:07 INFO - 'XPC_SERVICE_NAME': '0', 17:44:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:07 INFO - Downloading/unpacking psutil>=3.1.1 17:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:44:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:44:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:44:11 INFO - Installing collected packages: psutil 17:44:11 INFO - Running setup.py install for psutil 17:44:11 INFO - building 'psutil._psutil_osx' extension 17:44:11 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 17:44:11 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 17:44:12 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 17:44:12 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 17:44:12 INFO - building 'psutil._psutil_posix' extension 17:44:12 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 17:44:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:44:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:44:12 INFO - ^ 17:44:12 INFO - 1 warning generated. 17:44:12 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 17:44:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:44:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:44:12 INFO - Successfully installed psutil 17:44:12 INFO - Cleaning up... 17:44:12 INFO - Return code: 0 17:44:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:12 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 0x10bcadb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcb0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb314b6200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8bd30>, '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 0x10b9b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba80be8>, '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.SjjlJhW6fq/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.fAjwm7NhbL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 17:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:44:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjjlJhW6fq/Render', 17:44:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:12 INFO - 'HOME': '/Users/cltbld', 17:44:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:12 INFO - 'LOGNAME': 'cltbld', 17:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:12 INFO - 'MOZ_NO_REMOTE': '1', 17:44:12 INFO - 'NO_EM_RESTART': '1', 17:44:12 INFO - 'PAGER': '/bin/cat', 17:44:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:12 INFO - 'PWD': '/builds/slave/test', 17:44:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:12 INFO - 'SHELL': '/bin/bash', 17:44:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fAjwm7NhbL/Listeners', 17:44:12 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 17:44:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:12 INFO - 'USER': 'cltbld', 17:44:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:12 INFO - 'XPC_FLAGS': '0x0', 17:44:12 INFO - 'XPC_SERVICE_NAME': '0', 17:44:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:44:15 INFO - Installing collected packages: mozsystemmonitor 17:44:15 INFO - Running setup.py install for mozsystemmonitor 17:44:15 INFO - Successfully installed mozsystemmonitor 17:44:15 INFO - Cleaning up... 17:44:15 INFO - Return code: 0 17:44:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bcadb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcb0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb314b6200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8bd30>, '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 0x10b9b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba80be8>, '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.SjjlJhW6fq/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.fAjwm7NhbL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 17:44:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:44:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjjlJhW6fq/Render', 17:44:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:15 INFO - 'HOME': '/Users/cltbld', 17:44:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:15 INFO - 'LOGNAME': 'cltbld', 17:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:15 INFO - 'MOZ_NO_REMOTE': '1', 17:44:15 INFO - 'NO_EM_RESTART': '1', 17:44:15 INFO - 'PAGER': '/bin/cat', 17:44:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:15 INFO - 'PWD': '/builds/slave/test', 17:44:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:15 INFO - 'SHELL': '/bin/bash', 17:44:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fAjwm7NhbL/Listeners', 17:44:15 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 17:44:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:15 INFO - 'USER': 'cltbld', 17:44:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:15 INFO - 'XPC_FLAGS': '0x0', 17:44:15 INFO - 'XPC_SERVICE_NAME': '0', 17:44:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:15 INFO - Downloading/unpacking jsonschema==2.5.1 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:44:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:18 INFO - Downloading functools32-3.2.3-2.tar.gz 17:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:44:19 INFO - warning: no files found matching '*.txt' 17:44:19 INFO - no previously-included directories found matching 'build' 17:44:19 INFO - no previously-included directories found matching 'dist' 17:44:19 INFO - no previously-included directories found matching '.git*' 17:44:19 INFO - Installing collected packages: jsonschema, functools32 17:44:19 INFO - Running setup.py install for functools32 17:44:19 INFO - warning: no files found matching '*.txt' 17:44:19 INFO - no previously-included directories found matching 'build' 17:44:19 INFO - no previously-included directories found matching 'dist' 17:44:19 INFO - no previously-included directories found matching '.git*' 17:44:19 INFO - Successfully installed jsonschema functools32 17:44:19 INFO - Cleaning up... 17:44:19 INFO - Return code: 0 17:44:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bcadb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcb0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb314b6200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8bd30>, '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 0x10b9b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba80be8>, '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.SjjlJhW6fq/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.fAjwm7NhbL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 17:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:44:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjjlJhW6fq/Render', 17:44:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:19 INFO - 'HOME': '/Users/cltbld', 17:44:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:19 INFO - 'LOGNAME': 'cltbld', 17:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:19 INFO - 'MOZ_NO_REMOTE': '1', 17:44:19 INFO - 'NO_EM_RESTART': '1', 17:44:19 INFO - 'PAGER': '/bin/cat', 17:44:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:19 INFO - 'PWD': '/builds/slave/test', 17:44:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:19 INFO - 'SHELL': '/bin/bash', 17:44:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fAjwm7NhbL/Listeners', 17:44:19 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 17:44:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:19 INFO - 'USER': 'cltbld', 17:44:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:19 INFO - 'XPC_FLAGS': '0x0', 17:44:19 INFO - 'XPC_SERVICE_NAME': '0', 17:44:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:44:19 INFO - Cleaning up... 17:44:19 INFO - Return code: 0 17:44:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bcadb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcb0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb314b6200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8bd30>, '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 0x10b9b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba80be8>, '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.SjjlJhW6fq/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.fAjwm7NhbL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 17:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:44:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjjlJhW6fq/Render', 17:44:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:19 INFO - 'HOME': '/Users/cltbld', 17:44:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:19 INFO - 'LOGNAME': 'cltbld', 17:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:19 INFO - 'MOZ_NO_REMOTE': '1', 17:44:19 INFO - 'NO_EM_RESTART': '1', 17:44:19 INFO - 'PAGER': '/bin/cat', 17:44:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:19 INFO - 'PWD': '/builds/slave/test', 17:44:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:19 INFO - 'SHELL': '/bin/bash', 17:44:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fAjwm7NhbL/Listeners', 17:44:19 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 17:44:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:19 INFO - 'USER': 'cltbld', 17:44:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:19 INFO - 'XPC_FLAGS': '0x0', 17:44:19 INFO - 'XPC_SERVICE_NAME': '0', 17:44:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:19 INFO - Downloading/unpacking blobuploader==1.2.4 17:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:22 INFO - Downloading blobuploader-1.2.4.tar.gz 17:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:44:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:44:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44:23 INFO - Downloading docopt-0.6.1.tar.gz 17:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:44:23 INFO - Installing collected packages: blobuploader, requests, docopt 17:44:23 INFO - Running setup.py install for blobuploader 17:44:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:44:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:44:23 INFO - Running setup.py install for requests 17:44:24 INFO - Running setup.py install for docopt 17:44:24 INFO - Successfully installed blobuploader requests docopt 17:44:24 INFO - Cleaning up... 17:44:24 INFO - Return code: 0 17:44:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:24 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 0x10bcadb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcb0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb314b6200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8bd30>, '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 0x10b9b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba80be8>, '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.SjjlJhW6fq/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.fAjwm7NhbL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 17:44:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:44:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:44:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjjlJhW6fq/Render', 17:44:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:24 INFO - 'HOME': '/Users/cltbld', 17:44:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:24 INFO - 'LOGNAME': 'cltbld', 17:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:24 INFO - 'MOZ_NO_REMOTE': '1', 17:44:24 INFO - 'NO_EM_RESTART': '1', 17:44:24 INFO - 'PAGER': '/bin/cat', 17:44:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:24 INFO - 'PWD': '/builds/slave/test', 17:44:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:24 INFO - 'SHELL': '/bin/bash', 17:44:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fAjwm7NhbL/Listeners', 17:44:24 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 17:44:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:24 INFO - 'USER': 'cltbld', 17:44:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:24 INFO - 'XPC_FLAGS': '0x0', 17:44:24 INFO - 'XPC_SERVICE_NAME': '0', 17:44:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:24 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-gweppT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:24 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-5Fr8h4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-msUvoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-4AdSGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-k8tlRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-vCzaFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-n91Pe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-2RV7Hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-aEykrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-vJ9a3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-62eN5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-YmM4AJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:26 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-Z_cRpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:26 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-_mo6ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:26 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-Zh97CF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:26 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-0Jl75m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:26 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-RGRhkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:44:26 INFO - Running setup.py install for manifestparser 17:44:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:44:26 INFO - Running setup.py install for mozcrash 17:44:26 INFO - Running setup.py install for mozdebug 17:44:27 INFO - Running setup.py install for mozdevice 17:44:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:44:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:44:27 INFO - Running setup.py install for mozfile 17:44:27 INFO - Running setup.py install for mozhttpd 17:44:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:44:27 INFO - Running setup.py install for mozinfo 17:44:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:44:27 INFO - Running setup.py install for mozInstall 17:44:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:44:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:44:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:44:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:44:27 INFO - Running setup.py install for mozleak 17:44:27 INFO - Running setup.py install for mozlog 17:44:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:44:28 INFO - Running setup.py install for moznetwork 17:44:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:44:28 INFO - Running setup.py install for mozprocess 17:44:28 INFO - Running setup.py install for mozprofile 17:44:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:44:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:44:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:44:28 INFO - Running setup.py install for mozrunner 17:44:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:44:28 INFO - Running setup.py install for mozscreenshot 17:44:28 INFO - Running setup.py install for moztest 17:44:29 INFO - Running setup.py install for mozversion 17:44:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:44:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:44:29 INFO - Cleaning up... 17:44:29 INFO - Return code: 0 17:44:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:29 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 0x10bcadb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcb0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb314b6200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8bd30>, '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 0x10b9b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba80be8>, '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.SjjlJhW6fq/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.fAjwm7NhbL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 17:44:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:44:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjjlJhW6fq/Render', 17:44:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:29 INFO - 'HOME': '/Users/cltbld', 17:44:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:29 INFO - 'LOGNAME': 'cltbld', 17:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:29 INFO - 'MOZ_NO_REMOTE': '1', 17:44:29 INFO - 'NO_EM_RESTART': '1', 17:44:29 INFO - 'PAGER': '/bin/cat', 17:44:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:29 INFO - 'PWD': '/builds/slave/test', 17:44:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:29 INFO - 'SHELL': '/bin/bash', 17:44:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fAjwm7NhbL/Listeners', 17:44:29 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 17:44:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:29 INFO - 'USER': 'cltbld', 17:44:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:29 INFO - 'XPC_FLAGS': '0x0', 17:44:29 INFO - 'XPC_SERVICE_NAME': '0', 17:44:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:29 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-GyJU6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:29 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-VIrEQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:29 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-BlIUv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:29 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-5VUdVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:29 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-atsVu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-JgdP7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-KOmoiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-RKjvwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-bkfCK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-KbX5un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-1YKkAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-kysSM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-tMcct3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-gJNjsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:31 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-Xyk3Xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:31 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-59U51V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:31 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-8Ghnsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:44:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:44:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:44:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:44:31 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:44:31 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:44:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:33 INFO - Downloading blessings-1.6.tar.gz 17:44:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:44:34 INFO - Installing collected packages: blessings 17:44:34 INFO - Running setup.py install for blessings 17:44:34 INFO - Successfully installed blessings 17:44:34 INFO - Cleaning up... 17:44:34 INFO - Return code: 0 17:44:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:44:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:34 INFO - Reading from file tmpfile_stdout 17:44:34 INFO - Current package versions: 17:44:34 INFO - blessings == 1.6 17:44:34 INFO - blobuploader == 1.2.4 17:44:34 INFO - docopt == 0.6.1 17:44:34 INFO - functools32 == 3.2.3-2 17:44:34 INFO - jsonschema == 2.5.1 17:44:34 INFO - manifestparser == 1.1 17:44:34 INFO - mozInstall == 1.12 17:44:34 INFO - mozcrash == 1.0 17:44:34 INFO - mozdebug == 0.1 17:44:34 INFO - mozdevice == 0.49 17:44:34 INFO - mozfile == 1.2 17:44:34 INFO - mozhttpd == 0.7 17:44:34 INFO - mozinfo == 0.9 17:44:34 INFO - mozleak == 0.1 17:44:34 INFO - mozlog == 3.4 17:44:34 INFO - moznetwork == 0.27 17:44:34 INFO - mozprocess == 0.24 17:44:34 INFO - mozprofile == 0.28 17:44:34 INFO - mozrunner == 6.13 17:44:34 INFO - mozscreenshot == 0.1 17:44:34 INFO - mozsystemmonitor == 0.3 17:44:34 INFO - moztest == 0.8 17:44:34 INFO - mozversion == 1.4 17:44:34 INFO - psutil == 3.1.1 17:44:34 INFO - requests == 1.2.3 17:44:34 INFO - wsgiref == 0.1.2 17:44:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:34 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 0x10bcadb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcb0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb314b6200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8bd30>, '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 0x10b9b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba80be8>, '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.SjjlJhW6fq/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.fAjwm7NhbL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 17:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:44:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjjlJhW6fq/Render', 17:44:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:34 INFO - 'HOME': '/Users/cltbld', 17:44:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:34 INFO - 'LOGNAME': 'cltbld', 17:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:34 INFO - 'MOZ_NO_REMOTE': '1', 17:44:34 INFO - 'NO_EM_RESTART': '1', 17:44:34 INFO - 'PAGER': '/bin/cat', 17:44:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:34 INFO - 'PWD': '/builds/slave/test', 17:44:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:34 INFO - 'SHELL': '/bin/bash', 17:44:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fAjwm7NhbL/Listeners', 17:44:34 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 17:44:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:34 INFO - 'USER': 'cltbld', 17:44:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:34 INFO - 'XPC_FLAGS': '0x0', 17:44:34 INFO - 'XPC_SERVICE_NAME': '0', 17:44:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:44:34 INFO - Cleaning up... 17:44:34 INFO - Return code: 0 17:44:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:34 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 0x10bcadb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcb0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb314b6200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8bd30>, '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 0x10b9b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba80be8>, '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.SjjlJhW6fq/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.fAjwm7NhbL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 17:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:44:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjjlJhW6fq/Render', 17:44:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:34 INFO - 'HOME': '/Users/cltbld', 17:44:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:34 INFO - 'LOGNAME': 'cltbld', 17:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:34 INFO - 'MOZ_NO_REMOTE': '1', 17:44:34 INFO - 'NO_EM_RESTART': '1', 17:44:34 INFO - 'PAGER': '/bin/cat', 17:44:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:34 INFO - 'PWD': '/builds/slave/test', 17:44:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:34 INFO - 'SHELL': '/bin/bash', 17:44:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fAjwm7NhbL/Listeners', 17:44:34 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 17:44:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:34 INFO - 'USER': 'cltbld', 17:44:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:34 INFO - 'XPC_FLAGS': '0x0', 17:44:34 INFO - 'XPC_SERVICE_NAME': '0', 17:44:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:44:35 INFO - Cleaning up... 17:44:35 INFO - Return code: 0 17:44:35 INFO - Running post-action listener: _resource_record_post_action 17:44:35 INFO - Running post-action listener: _start_resource_monitoring 17:44:35 INFO - Starting resource monitoring. 17:44:35 INFO - [mozharness: 2017-03-04 01:44:35.115899Z] Finished create-virtualenv step (success) 17:44:35 INFO - [mozharness: 2017-03-04 01:44:35.116861Z] Running install step. 17:44:35 INFO - Running pre-action listener: _resource_record_pre_action 17:44:35 INFO - Running main action method: install 17:44:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:35 INFO - Reading from file tmpfile_stdout 17:44:35 INFO - Detecting whether we're running mozinstall >=1.0... 17:44:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:44:35 INFO - Reading from file tmpfile_stdout 17:44:35 INFO - Output received: 17:44:35 INFO - Usage: mozinstall [options] installer 17:44:35 INFO - Options: 17:44:35 INFO - -h, --help show this help message and exit 17:44:35 INFO - -d DEST, --destination=DEST 17:44:35 INFO - Directory to install application into. [default: 17:44:35 INFO - "/builds/slave/test"] 17:44:35 INFO - --app=APP Application being installed. [default: firefox] 17:44:35 INFO - mkdir: /builds/slave/test/build/application 17:44:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 17:44:55 INFO - Reading from file tmpfile_stdout 17:44:55 INFO - Output received: 17:44:55 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 17:44:55 INFO - Running post-action listener: _resource_record_post_action 17:44:55 INFO - [mozharness: 2017-03-04 01:44:55.409101Z] Finished install step (success) 17:44:55 INFO - [mozharness: 2017-03-04 01:44:55.409245Z] Running run-tests step. 17:44:55 INFO - Running pre-action listener: _resource_record_pre_action 17:44:55 INFO - Running main action method: run_tests 17:44:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:44:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:44:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:44:55 INFO - 2017-03-03 17:44:55.424 screenresolution[1968:12644] starting screenresolution argv=screenresolution get 17:44:55 INFO - 2017-03-03 17:44:55.426 screenresolution[1968:12644] Display 0: 1600x1200x32@60 17:44:55 INFO - 2017-03-03 17:44:55.432 screenresolution[1969:12647] starting screenresolution argv=screenresolution list 17:44:55 INFO - Available Modes on Display 0 17:44:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:44:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:44:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:44:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:44:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:44:55 INFO - Intel Iris: 17:44:55 INFO - Chipset Model: Intel Iris 17:44:55 INFO - Type: GPU 17:44:55 INFO - Bus: Built-In 17:44:55 INFO - VRAM (Dynamic, Max): 1536 MB 17:44:55 INFO - Vendor: Intel (0x8086) 17:44:55 INFO - Device ID: 0x0a2e 17:44:55 INFO - Revision ID: 0x0009 17:44:55 INFO - Displays: 17:44:55 INFO - Display: 17:44:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:44:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:44:55 INFO - Display Serial Number: 1600x1200 60 17:44:55 INFO - Main Display: Yes 17:44:55 INFO - Mirror: Off 17:44:55 INFO - Online: Yes 17:44:55 INFO - Rotation: Supported 17:44:55 INFO - Return code: 0 17:44:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:44:55 INFO - Python 2.7.3 17:44:55 INFO - Return code: 0 17:44:55 INFO - grabbing minidump binary from tooltool 17:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:55 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 0x10ba8bd30>, '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 0x10b9b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba80be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:44:55 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 17:44:55 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 17:44:55 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 17:44:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:44:55 INFO - Return code: 0 17:44:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:44:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:44:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:44:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:44:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:44:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0098 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:44:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjjlJhW6fq/Render', 17:44:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:55 INFO - 'HOME': '/Users/cltbld', 17:44:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:55 INFO - 'LOGNAME': 'cltbld', 17:44:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:44:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:55 INFO - 'MOZ_NO_REMOTE': '1', 17:44:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:44:55 INFO - 'NO_EM_RESTART': '1', 17:44:55 INFO - 'PAGER': '/bin/cat', 17:44:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:55 INFO - 'PWD': '/builds/slave/test', 17:44:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:44:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:55 INFO - 'SHELL': '/bin/bash', 17:44:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fAjwm7NhbL/Listeners', 17:44:55 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 17:44:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:55 INFO - 'USER': 'cltbld', 17:44:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:55 INFO - 'XPC_FLAGS': '0x0', 17:44:55 INFO - 'XPC_SERVICE_NAME': '0', 17:44:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:44:55 INFO - mozversion application_buildid: 20170303162023 17:44:55 INFO - mozversion application_changeset: e11b1a808700d7428c6ce94ca22921ae000424c1 17:44:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:44:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:44:55 INFO - mozversion application_name: Firefox 17:44:55 INFO - mozversion application_remotingname: firefox-dev 17:44:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:44:55 INFO - mozversion application_vendor: Mozilla 17:44:55 INFO - mozversion application_version: 53.0a2 17:44:55 INFO - mozversion platform_buildid: 20170303162023 17:44:55 INFO - mozversion platform_changeset: e11b1a808700d7428c6ce94ca22921ae000424c1 17:44:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:44:55 INFO - mozversion platform_version: 53.0a2 17:44:55 INFO - using testdate: 1488591895 17:44:55 INFO - actual date: 1488591895 17:44:55 INFO - starting webserver on 'localhost:49347' 17:44:55 INFO - SUITE-START | Running 2 tests 17:44:55 INFO - TEST-START | dromaeo_css 17:44:55 INFO - operating with platform_type : mac_ 17:44:55 INFO - Initialising browser for dromaeo_css test... 17:44:55 INFO - TEST-INFO | started process 1979 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmp5iKOYn/profile http://localhost:49347/getInfo.html) 17:44:58 INFO - PROCESS | 1979 | __metrics Screen width/height:1600/1200 17:44:58 INFO - PROCESS | 1979 | colorDepth:24 17:44:58 INFO - PROCESS | 1979 | Browser inner width/height: 1024/689 17:44:58 INFO - PROCESS | 1979 | __metrics 17:44:58 INFO - PROCESS | 1979 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:44:58 INFO - PROCESS | 1979 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:44:59 INFO - TEST-INFO | 1979: exit 0 17:44:59 INFO - Browser initialized. 17:44:59 INFO - Running cycle 1/1 for dromaeo_css test... 17:44:59 INFO - TEST-INFO | started process 1981 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmp5iKOYn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:11 INFO - PROCESS | 1981 | RSS: Main: 212652032 17:45:11 INFO - PROCESS | 1981 | 17:48:14 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49347/tests/dromaeo/cssquery-ext.html) 17:48:16 INFO - PROCESS | 1981 | RSS: Main: 309489664 17:48:16 INFO - PROCESS | 1981 | 17:50:00 INFO - PROCESS | 1981 | ************************* 17:50:00 INFO - PROCESS | 1981 | A coding exception was thrown and uncaught in a Task. 17:50:00 INFO - PROCESS | 1981 | 17:50:00 ERROR - PROCESS | 1981 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:50:00 INFO - PROCESS | 1981 | Full stack: 17:50:00 INFO - PROCESS | 1981 | ************************* 17:51:19 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-ext.html (next: http://localhost:49347/tests/dromaeo/cssquery-jquery.html) 17:51:20 INFO - PROCESS | 1981 | RSS: Main: 355926016 17:51:20 INFO - PROCESS | 1981 | 17:54:22 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49347/tests/dromaeo/cssquery-mootools.html) 17:54:23 INFO - PROCESS | 1981 | RSS: Main: 326373376 17:54:23 INFO - PROCESS | 1981 | 17:57:25 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49347/tests/dromaeo/cssquery-prototype.html) 17:57:26 INFO - PROCESS | 1981 | RSS: Main: 325791744 17:57:26 INFO - PROCESS | 1981 | 18:00:29 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49347/tests/dromaeo/cssquery-yui.html) 18:00:30 INFO - PROCESS | 1981 | RSS: Main: 309702656 18:00:30 INFO - PROCESS | 1981 | 18:03:33 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-yui.html (next: http://localhost:49347/tests/dromaeo/cssquery-dojo.html) 18:03:34 INFO - PROCESS | 1981 | RSS: Main: 409399296 18:03:34 INFO - PROCESS | 1981 | 18:03:34 INFO - PROCESS | 1981 | __start_tp_report 18:03:34 INFO - PROCESS | 1981 | _x_x_mozilla_page_load 18:03:34 INFO - PROCESS | 1981 | _x_x_mozilla_page_load_details 18:03:34 INFO - PROCESS | 1981 | |i|pagename|runs| 18:03:34 INFO - PROCESS | 1981 | |0;dojo.html;3317.237035481839;3321.4021476134303;3343.364760695466;3368.679975402336;3398.371301309258;5602.691851948141;5647.689377084259;5668.518175955039;5691.544676425887;5695.715214239292;5529.695866727328;5660.575456840743;5688.260526131608;5688.943110568893;5695.686737229461;5162.199859021857;5164.845054648357;5228.47715228478;5229.398619158788;5280.075986702331;5120.539151476366;5130.538251557359;5284.8150314739;5301.814436494724;5325.7869685212545;4393.648508119359;5167.173252279636;5186.766595503193;5211;5251.606129540281;5203.271541984125;5240.973795131038;5248.842534723926;5255.474452554714;5263.157894736823;5101.923471147936;5156.535911767922;5177.663451875616;5198.766055527511;5216.765245563959;5465.726713664301;5536.584756143306;5540;5570.6657600543695;5591.41290164535;6183.567150299481;6214.813555593294;6226.750929962796;6236.469900058501;6242.906356404657;4808.374911261549;6248.562600617958;6259.843503912393;6269.341719119518;6285.214348206474;5639.2668953035845;5645.435456454322;5685.1756495307945;5790.565707571906;5795.391483894173;6166.414190651881;6211.503079753609;6269.122322874801;6269.65516896566;6285.371462853769;6046.365131661112;6085.604435711664;6108.450239478469;6112.572119951649;6131.478824299985;6169.444749972524;6254.093156492283;6262.405071518198;6263;6270;5991.9700401498585;6058.939410605925;6080.635161890301;6109.412671190334;6110.01202914832;6086.60437071589;6125.754969801247;6125.9693701531205;6148.385161483816;6158.969205153946;4926.45808961014;4961.603071754251;4974.825881094144;4979.078870408914;5000.824971125993;4445.911081778411;4454.086912182995;4457.910841783211;4459.843905463294;4467.843625473158;5598.496135347838;5655.971720141373;5671.376148623648;5693.572982026365;5718.370979192286;6185.474234690102;6230;6247.562670613013;6304;6331.461825744771;5719.628224165499;5767.596288141258;5770.855728606734;5789.015867302484;5824.359320474744;5160.870978225499;5199.844004679866;5412.215228791803;5414.431484694129;5433.0763770159165;6232.999999999909;6248.094026366242;6286.308506064421;6288.905666415099;6336.493080553452;6269.74921003173;6272.4982001440685;6281.371862813682;6286.622802631857;6295.464885484785;6186.597871138361;6303.149074874833;6310.873782524232;6311.873762524816;6341.112244285711;6042.0936859469675;6104.236970378703;6111.895622426936;6211.627302361872;6227.283862355705;6183.103449999815;6285.214348206474;6287.717052732546;6290.24517057956;6292.024736165901;5026.648134630541;5227.7453411181805;6060.969635161945;6082.574219804571;6091.42131497507;5833.300003999547;5905.202797622438;6019.217501724747;6036.154938308729;6074.939250607437;5774;5779.306483222041;5780.104083867007;5864.589478736448;5889.440503152194;5868.501177399969;5930.762769489172;6003.279606447254;6024.216851809237;6030.065339872327;5818.214541037075;5823.068309070529;5895.793647222326;5903.173555702291;5955.047192449188 18:03:34 INFO - PROCESS | 1981 | |1;ext.html;441.752618533621;449.16903728102994;493.7654614058323;505.07319069507463;518.1088527732302;30666.54000189999;32295;32320.353592928128;32425.86509472169;41156.97107572312;42227.36658950118;44249.55750442495;44337.334939975924;44344.891377715576;44431.66704998847;9157.679481218176;9350.719478415658;9356.859647105299;9378.437293762361;9384.953075234615;8314.83370332593;8551.18763717449;9212.170904618582;9392.859107113365;9396.906030939706;8427.873581896276;8487.108853570378;8491;11111.611093611726;11394.886051139465;11241.381724005176;11323.490442930088;11334.43327833605;11344.035756960586;11357.375344356056;11255.493502792395;11343.205975581712;11351.375674337909;11377.374244416555;11385.316880987084;31286.21784455384;31837.681623183704;40204;40878.795606022075;41074.794626026975;3941.2708648899757;3948.0773451998402;3958.9010274743073;3963.8810835674976;4043.7573745575064;29691.554626680616;30864.228394290098;31296.21759456009;31508.36983260345;32097.6790232097;3120.8127512349333;3196;3204.1524218301693;3229.4832826747606;3254.3165935153647;459285;469914;470219.99999999657;471649;473522;54910.90178196494;61397.38602614006;62559.37440625626;63513;63814;66547.66726166339;66637.66681166564;66687.66656166785;66832;66978.65106744644;16313.673726525403;16689.998600084033;16710.498685039467;16721.665566688596;16722.58193545171;12914.935425323001;12995.935020325027;13015.934920325528;13025.804612930813;13039.804402933964;15441.613959650875;16174.27215775293;16224.675506489804;16818.495445136665;16858.24137913797;5834.474897259267;6540.738370465128;7152;7176.7846964591145;7211.206767255598;845.6659619450282;854.9016863060704;865.5109862927426;884.6019291318933;918.554501066982;28727.563621818827;29302.706972930424;29954.400911982073;30111;30822.53766193509;1064.8136576099153;1073.9570417183224;1098.9725256868483;1106.9391183484986;1174.2250114924109;14168.858311416754;14587.635309117357;14731.705365892622;14879.776803347959;15262.313195905988;595832;622404;624256;626185;626727;54357;54369.728151359785;54375.6406089843;54449.72775136099;54494.45505544973;1390.8122403475402;1418.560246323643;1431.8424973252934;1439.8776104031274;1441.4882716635652;23415.648765268194;27988.880444781982;28758;29197.270068248465;29346.266343341587;38092.238155236184;47230.76384618055;47339.053218934736;47342.52657473381;47425;455561;458496;459621;459686;460202;24374.025038998243;24380.75619243785;24420.389490262885;24816.50366992614;25086;36564.903052908456;37702;42371.7881410591;43932.78033609811;44348.33477497905;31994.52008219925;34343.82828085843;36478.27043459169;37471.81264093662;37761.62238377581;35527;35951;36074.81962590275;37195.44206836846;37383;34956.47565286472;35145.82427087848;35279.11802204965;35722.8213858929;35737.64262357447;28058.4913855505;29822;32266.83866580652;32589;32603;22944.54110917739;23674.171404000776;23735.643965340878;23961.28116156518;24298 18:03:34 INFO - PROCESS | 1981 | |2;jquery.html;391.7571105914333;394.40051122294113;401.3838757507227;401.8794361691492;425.948886133664;13496.730065398711;17356.305747770104;19772.40682779517;20944.26695065675;20952.057157427935;20853.582928341424;21132.8943355283;21200.469988250265;21638.134474621034;21996;5191.480851914806;5565.998120338358;5689.772409103631;5691.886162276752;5705.629134106291;5441.319835020622;5562.9443705563035;5659.745311460994;5665.1502274658715;5674;4758.500357462469;5700.657960522382;5701.230333904911;5706.514946229576;5711.143328500717;5444.673319600836;5518.061929471999;5696.971515142419;5701.258836351269;5715.142728590724;4950.87622809429;4956.3804524434445;4960.528749768766;4964.900701985976;4973.278874563204;25365;25685.48629027409;25878.353041173934;25986.960521579113;26085.869570652216;2308.7575804540447;2585.767280944724;2609.9869500652567;2650.5494066008823;2691.650085488874;14918.776218356734;15301.540953771404;15655.373785048585;15767.605809854846;15904.602384940354;1734.3314954001842;1790.516560528663;1791.552111972007;1794.3181590995468;1829.3140072472822;115031.19625644892;117583;121433.39283303526;122337;122643;9838.508074596242;11366.261193022427;11435.485403156878;11896.22674526153;11899.107566932342;14313.212773297568;14884.73479754233;15477.613059673598;15663.843361566467;15686.9215653921;8261.710840120568;8705.564721763887;8889.19997200255;9031.729048128567;9080.8637870432;8561.143885611513;8561.571921403905;8721.694740684046;8793.956030219935;8824.77938051541;4833.830815921426;4855.1260773060485;4863.10032643962;4863.756812159378;4941.901161976741;2008.3974807557674;2049.7540295164677;2052.969205461919;2056.3830850744716;2056.814886660208;855.6149732620346;1014.7564584499667;1026.8973102689672;1036.0934182590233;1043.5721354244724;21115.788842111688;21549.138034478445;21828;22021.779782202295;22105.115795368005;872.8952525696957;1018.6587493189865;1043.7599352149048;1049.464772965793;1062.4528367890543;10929;11342.262752921033;11414.885851141382;11487.483063262172;11587.073034157247;754602;762134.1893290608;769034;788781;788973;146551;147662.26168869087;150328.49671503145;150483;150585;1000.5497526113278;1014.9695509134738;1034.3535290443472;1038.8078205532001;1049.2917280835559;18628;19099.14053867607;19336.709949351054;19350.612987739885;19440;54995.72502137464;59663.701681491315;60149.49626259204;60243.39756602378;61389;82308;84085;84257;84659.5767021161;85805;7976.960115199387;8282.337413007066;8547.95726021366;8611.397202195787;8747.562621868754;9100.499472529074;13243.80134297967;13833.930830346186;13855.722885542435;13926.860731392962;11309.377984210947;11352.148588855704;11457.885421145682;11805;11849.703757406134;11416.372099534605;11439.542418303176;11712.472938717949;11909.987651049758;11952.223105498115;6059.818205453844;7505.8498830022;11509.446224759551;11645.301281923112;12092.455839487067;8340.374471914509;8453.95773021131;8569.314454843472;8612.48325100496;8648.005479369953;9005.954970225106;9122.407043542149;11555.480003400035;11857.822132667845;11900.523979040741 18:03:34 INFO - PROCESS | 1981 | |3;mootools.html;1435.4904009076777;1438.5340084959055;1440.6902515959066;1459.7226526959878;1459.8029266049084;8045.718399856006;8513.53175575343;8521.105283945182;8521.957390213049;8527.573621318925;7405.074365704287;7646.885296720554;7655.464117511762;7997.6001199940065;8284.295834854045;2291.186628746796;2329.860208387502;2334.9299521014314;2337.298810356886;2340.8127349811975;2299.5630830142304;2324.6396808494624;2350.5416443793465;2357.457784709518;2361.822863285252;2335.1359996801207;2343.179887039531;2362.692849929507;2369.6327069304284;2369.656399822025;2284.291869520454;2287.553926984239;2312.4450131968374;2312.456572705413;2316.872572008539;1981.7522809648794;2324.779145981129;2352.6235802271726;2356.599378105726;2357.6463530470396;8225.341972642174;8369.623366948503;8378.287845533137;8380.497170169809;8380.8742868857;4991.5258050485145;5143.974280128613;5154.536091751723;5156.407013193493;5191.091558977164;2967.3471836196004;3283.8522266497826;3303.0751389610946;3424.1610805352598;3487.825608719579;1005.6480231918842;1152.573547787324;1166.2710805746408;1211.9757604847941;1214.8602910665297;10549.050585447423;10570.048695617354;10689.984451477098;10725.570977160904;10745.731356716067;4446.244138496463;4583.243764778841;4666.230072038075;4680.976595117071;4726.149293127201;9508.429494230368;9512.38169518979;9521.90478095224;9542.33203675736;9624.326297159132;5220.347456567929;5221.425643179247;5221.477852214824;5222.294990176353;5225.111731005738;4096.119334343071;4362.476502819682;4624.97687511567;4724.244120940702;4758.714477131383;3823.7323387362617;3853.8651147210276;3958.3072962231495;3973.6026397360033;3994.0414300568236;1104.8563686720674;1147.4549588945183;1244.1788419642992;1275.5854347337151;1299.4802079168408;652.2824892618082;744.7989042958371;750.5121670913841;791.9802004949807;824.9010118785784;5152.742362881841;5382.3541175059245;5574.804881829116;5629.7185140742795;5639.689817060019;466.42163716991365;466.5637628817067;570.848725087852;571.5856004396779;577.209223363994;3116.2209447638093;3554.1647712787476;3568.518250036264;3641.1807343347537;3673.9265214696093;9362.765930851783;9865.260105492116;9882.407055576545;9893.15908147801;9919.553620086968;9694;9841.852372214422;9842.901570984342;9844.901550984541;9865.605375784888;7521.586312752742;7629.427792915553;7669.348105410991;7774.2614451627005;7789.1042530108625;5255.763490642854;5362.302900622894;5465.699386533779;5551.944480555143;5651;8957.955210224169;8977.685780997634;9046.90953090487;9076.863847042168;9152.771180720536;8768.342374321825;9309.906900931175;9318.627254909728;9325.114114159143;9360.906390936003;6581.473482121323;6800;7126.821829454305;7216;7224.313690199423;7469.477136600603;7470.2903224193615;7614.124375696866;7705.884411733717;7810.336121429742;6716.227633821977;6792.0830687856505;6808.489363297674;6850.45196384298;6941.722331106699;6431.260405053292;6462.579932304385;6480.416762491398;6480.773172938924;6508.544401891822;6241.812745617639;6284.811455656338;6310.842228944313;6315.684215789284;6332.30344662096;4753.429588449409;4761.76191190446;4799.352087468147;4906.975465122651;5028.195488721787;4884.682495637772;4917.237828136645;4955.058538877746;4977.979514199508;4993.750312484434 18:03:34 INFO - PROCESS | 1981 | |4;prototype.html;354.20304315290593;357.24977547150985;362.5685434333144;374.5299648940579;375.71633416770334;4838.225883858583;4969.229769385751;5008.672701734044;5105.4894510548975;5479.328804714561;4261.487172053923;4576.725396476206;4628.62970962323;5039.41258503572;5234.162533994561;3658.3414985302634;4102.5897410258885;4186.183694179636;4193.454850869382;4210.557891421403;4154.729942553739;4170.9582904170875;4177.3499467710235;4178.7283826551175;4256.531781504032;3281.409346317662;3778.7530115061963;3976.443297938291;4169.291220492509;4192.517860446042;3385.881494147693;3969.8412063517567;4103.13834094839;4126.896827579305;4156.521999969982;2891.580720795473;3668.394714872043;3685.3366394049062;3686.9078273043388;3696.8706095286807;4000.159966407029;5172.870678233036;5186.662866913639;5196.45437229093;5213.187296164749;4570.748608826513;4799.352087468217;4805.543473370024;4816.349792777965;4824.855254342376;4261;4661.207594708908;5321.627486075976;5621.606487545873;5631.943680563183;4068.430419741209;4080.0411903202726;4093.97953010236;4102.815373308178;4109.732867363612;4830.516948305177;5020.59835213182;5196.842525979201;5927.762889484372;5984;3553.596329449853;3724.031751744512;3841.8891785789497;3853.0734632683657;3853.5915053091817;3396.864125434955;3877.9917221522605;3923.7449565778134;3926;3948.8617898373996;3981.5222173338807;4359.716618419792;4550.749708765983;4560.543945605413;4610.884727881829;5200.5059519345605;5669.569910204267;5696.943030569724;5700.377826199911;5709.316621188035;1266.7719810434025;1277.9424925878172;1286.247545186058;1286.75551645189;1294.1558279451745;681.8840797064511;738.7931379213828;808.6441965535263;812.524673066251;864.5979619476848;4260.825684864795;4501.8295243237;4594.1730488512385;4660.557247061523;4938.728369939688;4719.9292010619865;4861.319415281863;5437.782488700487;5449.591280653967;5556.91664625031;4537.478190008192;4546.499885012646;4601.861944141681;4750.786214620351;4981.227909674007;2276.499170182557;2749.257700420915;2855.1862719125365;2873.8994135205166;2881.4381195667065;4893.584045356113;5191.5846732261325;5572.4706152916215;5787.305523337226;5794.130880367894;4603;4801.279808028824;4840.184930651006;4874.683145595525;5423.291663126102;4973.159930825545;5178.818741344035;5522.530584900248;5752.7698892043845;5822.94177058241;5426.918596220981;5494.642848214853;5499.395066542757;5563.7496312666835;5575.330960284792;5311.973440132929;5770.422957704196;5834.474897259267;5854.707264636836;5867.125108696793;6063.969680151571;6125.050617154348;6133.754649813957;6134.171886795226;6177.227846519185;3942.5466071402157;4127.628513433805;4191.937120943127;4266.168097221012;4290.1419716057535;4385.890352741207;5286.7356632169;5791.623544469596;5817.156512305776;5818.098194779646;4173.791310434527;4761.857154283017;5295.808443100272;5544.500994910478;5692.231548740867;4855.854324370274;4865.318855360181;5172.250023746611;5673.716314184357;5723.8855222896145;4984.775685094107;5228.032813929435;5534.418886017072;5600.69196194197;5628.549716022791;5195.246689230116;5443.482869127585;5515.503604675599;5560.883986732297;5587.429782300025;5472.808451704172;5475.945240547703;5495;5520.466901183327;5527.429745168516 18:03:34 INFO - PROCESS | 1981 | |5;yui.html;681.4037716997627;710.2187593646986;734.6290123487638;793.1592511937347;805.5690205739928;14349.426022959082;15386.307616157272;15452.69094618107;15467.917245792785;15471.613209669764;13579.388927498261;13757.724845503084;14045.92977035116;14054.086484378508;14162.150270983748;666.6766618190198;686.2519853359837;828.3538839705025;842.1662554071456;849.1890244816186;683.794861541538;810.7040930060544;837.4514692876145;837.7361131243639;840.3403328387217;883.4213590098495;896.7847716548014;897.2373482539854;899.4423457456386;900.4867225681331;893.9150780675825;894.8434024045798;894.8612964990436;894.8791913091715;894.8836651235363;517.8550005998327;532.1113740054119;535.5126834580552;663.4294506724214;666.4235436347525;12518.74962500754;12565.371731413485;14002.789958150635;14527.273636318141;14546.199959002251;10826.350418974887;11655.417229138595;11766.941165294204;13250.536231231958;13474.663133421645;11124.332540047622;11574.189806713533;11712;11781.293122412682;11930.463129159209;3655.524781778352;3710.666040056408;3730.720195985312;3756.586775454698;3861.517310336208;107467;107946.99999999921;108836.4558177212;112770.43614781955;112993;10662.786744265071;10813.945930270298;10890.72773180661;10949.397783122005;10964.122870170368;21459.712417255014;22257.55484890293;22411.551768964528;22520;22548.549029019327;7100.000499577848;7109.786706398816;7145.535540189871;7178.928210717826;7203.963980180066;4161.542230354658;4264.850730224489;4288.952517298927;4365.563443655673;4437.534058923767;3531.434970404723;3600.7479476436397;3601.081724160322;3606.2426890353318;3640.690541304019;625.1435533319382;642.82322361351;646.0986923242145;653.6111013946694;661.890788019981;536.940936496985;609.3479976425272;675.2268652392983;688.3013741052836;692.3803196139427;9879;10028.548715307828;10717.83923241152;10879;11208.887911120784;593.2673148661399;598.984417435327;604.7732100462326;613.3743581546797;720.8522252938135;4646.744429056367;4870.902581948341;4990.426100998359;5005.649604527721;5007.924881126786;104032;104045;104382;104828.95171048344;105906;57474.5631359211;76881;76969;82655.17344826474;84457;73057;75901;77857.221427785;78821.81767273495;79344;10173.28786984904;10551.419671918118;10698.946505267424;10707.678769636923;10761.946190268998;47907.083716652334;48372.162783721345;48820;48909.2663610039;50103;63655;67103.32896670971;67245;69095;70055.237571546;10830.350178989285;12126.787321267802;13068.477260909458;13376.799348009983;13455.86544134546;14153.646158845699;14603.415863365346;15161.09033457996;15203.31585078652;15287.312070957056;13116.934415327862;13666;13931.930340348234;13988.440462381797;14344.924130690031;13293;13339.399727012114;13947.442102315794;13956.79064814049;14423.855761442252;12374.443150058089;13261.469541218243;13497.662558436117;13601.727965440834;13955.372008259856;10377.481125943823;11014.669559913216;11170.497327620114;11219.887801121884;11415.315081095161;10091.19270458347;10539.78920421572;10965.61620343284;10967.670969870916;11002.559897604006 18:03:34 INFO - PROCESS | 1981 | __end_tp_report 18:03:34 INFO - PROCESS | 1981 | __start_cc_report 18:03:34 INFO - PROCESS | 1981 | _x_x_mozilla_cycle_collect,2140 18:03:34 INFO - PROCESS | 1981 | __end_cc_report 18:03:34 INFO - PROCESS | 1981 | __startTimestamp1488593014086__endTimestamp 18:03:34 INFO - PROCESS | 1981 | 18:03:34 INFO - PROCESS | 1981 | ------- Summary: start ------- 18:03:34 INFO - PROCESS | 1981 | Number of tests: 6 18:03:34 INFO - PROCESS | 1981 | 18:03:34 INFO - PROCESS | 1981 | [#0] dojo.html Cycles:165 Average:5692.12 Median:5824.36 stddev:638.24 (11.0%) stddev-sans-first:612.40 18:03:34 INFO - PROCESS | 1981 | Values: 3317.2 3321.4 3343.4 3368.7 3398.4 5602.7 5647.7 5668.5 5691.5 5695.7 5529.7 5660.6 5688.3 5688.9 5695.7 5162.2 5164.8 5228.5 5229.4 5280.1 5120.5 5130.5 5284.8 5301.8 5325.8 4393.6 5167.2 5186.8 5211.0 5251.6 5203.3 5241.0 5248.8 5255.5 5263.2 5101.9 5156.5 5177.7 5198.8 5216.8 5465.7 5536.6 5540.0 5570.7 5591.4 6183.6 6214.8 6226.8 6236.5 6242.9 4808.4 6248.6 6259.8 6269.3 6285.2 5639.3 5645.4 5685.2 5790.6 5795.4 6166.4 6211.5 6269.1 6269.7 6285.4 6046.4 6085.6 6108.5 6112.6 6131.5 6169.4 6254.1 6262.4 6263.0 6270.0 5992.0 6058.9 6080.6 6109.4 6110.0 6086.6 6125.8 6126.0 6148.4 6159.0 4926.5 4961.6 4974.8 4979.1 5000.8 4445.9 4454.1 4457.9 4459.8 4467.8 5598.5 5656.0 5671.4 5693.6 5718.4 6185.5 6230.0 6247.6 6304.0 6331.5 5719.6 5767.6 5770.9 5789.0 5824.4 5160.9 5199.8 5412.2 5414.4 5433.1 6233.0 6248.1 6286.3 6288.9 6336.5 6269.7 6272.5 6281.4 6286.6 6295.5 6186.6 6303.1 6310.9 6311.9 6341.1 6042.1 6104.2 6111.9 6211.6 6227.3 6183.1 6285.2 6287.7 6290.2 6292.0 5026.6 5227.7 6061.0 6082.6 6091.4 5833.3 5905.2 6019.2 6036.2 6074.9 5774.0 5779.3 5780.1 5864.6 5889.4 5868.5 5930.8 6003.3 6024.2 6030.1 5818.2 5823.1 5895.8 5903.2 5955.0 18:03:34 INFO - PROCESS | 1981 | 18:03:34 INFO - PROCESS | 1981 | [#1] ext.html Cycles:180 Average:64855.13 Median:35844.32 stddev:139018.13 (387.8%) stddev-sans-first:139323.99 18:03:34 INFO - PROCESS | 1981 | Values: 441.8 449.2 493.8 505.1 518.1 30666.5 32295.0 32320.4 32425.9 41157.0 42227.4 44249.6 44337.3 44344.9 44431.7 9157.7 9350.7 9356.9 9378.4 9385.0 8314.8 8551.2 9212.2 9392.9 9396.9 8427.9 8487.1 8491.0 11111.6 11394.9 11241.4 11323.5 11334.4 11344.0 11357.4 11255.5 11343.2 11351.4 11377.4 11385.3 31286.2 31837.7 40204.0 40878.8 41074.8 3941.3 3948.1 3958.9 3963.9 4043.8 29691.6 30864.2 31296.2 31508.4 32097.7 3120.8 3196.0 3204.2 3229.5 3254.3 459285.0 469914.0 470220.0 471649.0 473522.0 54910.9 61397.4 62559.4 63513.0 63814.0 66547.7 66637.7 66687.7 66832.0 66978.7 16313.7 16690.0 16710.5 16721.7 16722.6 12914.9 12995.9 13015.9 13025.8 13039.8 15441.6 16174.3 16224.7 16818.5 16858.2 5834.5 6540.7 7152.0 7176.8 7211.2 845.7 854.9 865.5 884.6 918.6 28727.6 29302.7 29954.4 30111.0 30822.5 1064.8 1074.0 1099.0 1106.9 1174.2 14168.9 14587.6 14731.7 14879.8 15262.3 595832.0 622404.0 624256.0 626185.0 626727.0 54357.0 54369.7 54375.6 54449.7 54494.5 1390.8 1418.6 1431.8 1439.9 1441.5 23415.6 27988.9 28758.0 29197.3 29346.3 38092.2 47230.8 47339.1 47342.5 47425.0 455561.0 458496.0 459621.0 459686.0 460202.0 24374.0 24380.8 24420.4 24816.5 25086.0 36564.9 37702.0 42371.8 43932.8 44348.3 31994.5 34343.8 36478.3 37471.8 37761.6 35527.0 35951.0 36074.8 37195.4 37383.0 34956.5 35145.8 35279.1 35722.8 35737.6 28058.5 29822.0 32266.8 32589.0 32603.0 22944.5 23674.2 23735.6 23961.3 24298.0 18:03:34 INFO - PROCESS | 1981 | 18:03:34 INFO - PROCESS | 1981 | [#2] jquery.html Cycles:180 Average:41054.47 Median:22063.45 stddev:128157.51 (580.9%) stddev-sans-first:128480.65 18:03:34 INFO - PROCESS | 1981 | Values: 391.8 394.4 401.4 401.9 425.9 13496.7 17356.3 19772.4 20944.3 20952.1 20853.6 21132.9 21200.5 21638.1 21996.0 5191.5 5566.0 5689.8 5691.9 5705.6 5441.3 5562.9 5659.7 5665.2 5674.0 4758.5 5700.7 5701.2 5706.5 5711.1 5444.7 5518.1 5697.0 5701.3 5715.1 4950.9 4956.4 4960.5 4964.9 4973.3 25365.0 25685.5 25878.4 25987.0 26085.9 2308.8 2585.8 2610.0 2650.5 2691.7 14918.8 15301.5 15655.4 15767.6 15904.6 1734.3 1790.5 1791.6 1794.3 1829.3 115031.2 117583.0 121433.4 122337.0 122643.0 9838.5 11366.3 11435.5 11896.2 11899.1 14313.2 14884.7 15477.6 15663.8 15686.9 8261.7 8705.6 8889.2 9031.7 9080.9 8561.1 8561.6 8721.7 8794.0 8824.8 4833.8 4855.1 4863.1 4863.8 4941.9 2008.4 2049.8 2053.0 2056.4 2056.8 855.6 1014.8 1026.9 1036.1 1043.6 21115.8 21549.1 21828.0 22021.8 22105.1 872.9 1018.7 1043.8 1049.5 1062.5 10929.0 11342.3 11414.9 11487.5 11587.1 754602.0 762134.2 769034.0 788781.0 788973.0 146551.0 147662.3 150328.5 150483.0 150585.0 1000.5 1015.0 1034.4 1038.8 1049.3 18628.0 19099.1 19336.7 19350.6 19440.0 54995.7 59663.7 60149.5 60243.4 61389.0 82308.0 84085.0 84257.0 84659.6 85805.0 7977.0 8282.3 8548.0 8611.4 8747.6 9100.5 13243.8 13833.9 13855.7 13926.9 11309.4 11352.1 11457.9 11805.0 11849.7 11416.4 11439.5 11712.5 11910.0 11952.2 6059.8 7505.8 11509.4 11645.3 12092.5 8340.4 8454.0 8569.3 8612.5 8648.0 9006.0 9122.4 11555.5 11857.8 11900.5 18:03:34 INFO - PROCESS | 1981 | 18:03:34 INFO - PROCESS | 1981 | [#3] mootools.html Cycles:180 Average:5337.04 Median:5221.89 stddev:2933.98 (56.2%) stddev-sans-first:2927.56 18:03:34 INFO - PROCESS | 1981 | Values: 1435.5 1438.5 1440.7 1459.7 1459.8 8045.7 8513.5 8521.1 8522.0 8527.6 7405.1 7646.9 7655.5 7997.6 8284.3 2291.2 2329.9 2334.9 2337.3 2340.8 2299.6 2324.6 2350.5 2357.5 2361.8 2335.1 2343.2 2362.7 2369.6 2369.7 2284.3 2287.6 2312.4 2312.5 2316.9 1981.8 2324.8 2352.6 2356.6 2357.6 8225.3 8369.6 8378.3 8380.5 8380.9 4991.5 5144.0 5154.5 5156.4 5191.1 2967.3 3283.9 3303.1 3424.2 3487.8 1005.6 1152.6 1166.3 1212.0 1214.9 10549.1 10570.0 10690.0 10725.6 10745.7 4446.2 4583.2 4666.2 4681.0 4726.1 9508.4 9512.4 9521.9 9542.3 9624.3 5220.3 5221.4 5221.5 5222.3 5225.1 4096.1 4362.5 4625.0 4724.2 4758.7 3823.7 3853.9 3958.3 3973.6 3994.0 1104.9 1147.5 1244.2 1275.6 1299.5 652.3 744.8 750.5 792.0 824.9 5152.7 5382.4 5574.8 5629.7 5639.7 466.4 466.6 570.8 571.6 577.2 3116.2 3554.2 3568.5 3641.2 3673.9 9362.8 9865.3 9882.4 9893.2 9919.6 9694.0 9841.9 9842.9 9844.9 9865.6 7521.6 7629.4 7669.3 7774.3 7789.1 5255.8 5362.3 5465.7 5551.9 5651.0 8958.0 8977.7 9046.9 9076.9 9152.8 8768.3 9309.9 9318.6 9325.1 9360.9 6581.5 6800.0 7126.8 7216.0 7224.3 7469.5 7470.3 7614.1 7705.9 7810.3 6716.2 6792.1 6808.5 6850.5 6941.7 6431.3 6462.6 6480.4 6480.8 6508.5 6241.8 6284.8 6310.8 6315.7 6332.3 4753.4 4761.8 4799.4 4907.0 5028.2 4884.7 4917.2 4955.1 4978.0 4993.8 18:03:34 INFO - PROCESS | 1981 | 18:03:34 INFO - PROCESS | 1981 | [#4] prototype.html Cycles:180 Average:4456.27 Median:4834.37 stddev:1354.40 (28.0%) stddev-sans-first:1322.74 18:03:34 INFO - PROCESS | 1981 | Values: 354.2 357.2 362.6 374.5 375.7 4838.2 4969.2 5008.7 5105.5 5479.3 4261.5 4576.7 4628.6 5039.4 5234.2 3658.3 4102.6 4186.2 4193.5 4210.6 4154.7 4171.0 4177.3 4178.7 4256.5 3281.4 3778.8 3976.4 4169.3 4192.5 3385.9 3969.8 4103.1 4126.9 4156.5 2891.6 3668.4 3685.3 3686.9 3696.9 4000.2 5172.9 5186.7 5196.5 5213.2 4570.7 4799.4 4805.5 4816.3 4824.9 4261.0 4661.2 5321.6 5621.6 5631.9 4068.4 4080.0 4094.0 4102.8 4109.7 4830.5 5020.6 5196.8 5927.8 5984.0 3553.6 3724.0 3841.9 3853.1 3853.6 3396.9 3878.0 3923.7 3926.0 3948.9 3981.5 4359.7 4550.7 4560.5 4610.9 5200.5 5669.6 5696.9 5700.4 5709.3 1266.8 1277.9 1286.2 1286.8 1294.2 681.9 738.8 808.6 812.5 864.6 4260.8 4501.8 4594.2 4660.6 4938.7 4719.9 4861.3 5437.8 5449.6 5556.9 4537.5 4546.5 4601.9 4750.8 4981.2 2276.5 2749.3 2855.2 2873.9 2881.4 4893.6 5191.6 5572.5 5787.3 5794.1 4603.0 4801.3 4840.2 4874.7 5423.3 4973.2 5178.8 5522.5 5752.8 5822.9 5426.9 5494.6 5499.4 5563.7 5575.3 5312.0 5770.4 5834.5 5854.7 5867.1 6064.0 6125.1 6133.8 6134.2 6177.2 3942.5 4127.6 4191.9 4266.2 4290.1 4385.9 5286.7 5791.6 5817.2 5818.1 4173.8 4761.9 5295.8 5544.5 5692.2 4855.9 4865.3 5172.3 5673.7 5723.9 4984.8 5228.0 5534.4 5600.7 5628.5 5195.2 5443.5 5515.5 5560.9 5587.4 5472.8 5475.9 5495.0 5520.5 5527.4 18:03:34 INFO - PROCESS | 1981 | 18:03:34 INFO - PROCESS | 1981 | [#5] yui.html Cycles:180 Average:20134.45 Median:3600.91 stddev:29038.64 (806.4%) stddev-sans-first:29083.36 18:03:34 INFO - PROCESS | 1981 | Values: 681.4 710.2 734.6 793.2 805.6 14349.4 15386.3 15452.7 15467.9 15471.6 13579.4 13757.7 14045.9 14054.1 14162.2 666.7 686.3 828.4 842.2 849.2 683.8 810.7 837.5 837.7 840.3 883.4 896.8 897.2 899.4 900.5 893.9 894.8 894.9 894.9 894.9 517.9 532.1 535.5 663.4 666.4 12518.7 12565.4 14002.8 14527.3 14546.2 10826.4 11655.4 11766.9 13250.5 13474.7 11124.3 11574.2 11712.0 11781.3 11930.5 3655.5 3710.7 3730.7 3756.6 3861.5 107467.0 107947.0 108836.5 112770.4 112993.0 10662.8 10813.9 10890.7 10949.4 10964.1 21459.7 22257.6 22411.6 22520.0 22548.5 7100.0 7109.8 7145.5 7178.9 7204.0 4161.5 4264.9 4289.0 4365.6 4437.5 3531.4 3600.7 3601.1 3606.2 3640.7 625.1 642.8 646.1 653.6 661.9 536.9 609.3 675.2 688.3 692.4 9879.0 10028.5 10717.8 10879.0 11208.9 593.3 599.0 604.8 613.4 720.9 4646.7 4870.9 4990.4 5005.6 5007.9 104032.0 104045.0 104382.0 104829.0 105906.0 57474.6 76881.0 76969.0 82655.2 84457.0 73057.0 75901.0 77857.2 78821.8 79344.0 10173.3 10551.4 10698.9 10707.7 10761.9 47907.1 48372.2 48820.0 48909.3 50103.0 63655.0 67103.3 67245.0 69095.0 70055.2 10830.4 12126.8 13068.5 13376.8 13455.9 14153.6 14603.4 15161.1 15203.3 15287.3 13116.9 13666.0 13931.9 13988.4 14344.9 13293.0 13339.4 13947.4 13956.8 14423.9 12374.4 13261.5 13497.7 13601.7 13955.4 10377.5 11014.7 11170.5 11219.9 11415.3 10091.2 10539.8 10965.6 10967.7 11002.6 18:03:34 INFO - PROCESS | 1981 | -------- Summary: end -------- 18:03:34 INFO - PROCESS | 1981 | 18:03:34 INFO - TEST-INFO | 1981: exit 0 18:03:34 INFO - TEST-OK | dromaeo_css | took 1118783ms 18:03:34 INFO - TEST-START | kraken 18:03:34 INFO - operating with platform_type : mac_ 18:03:34 INFO - Initialising browser for kraken test... 18:03:34 INFO - TEST-INFO | started process 1983 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmp23srQl/profile http://localhost:49347/getInfo.html) 18:03:37 INFO - PROCESS | 1983 | __metrics Screen width/height:1600/1200 18:03:37 INFO - PROCESS | 1983 | colorDepth:24 18:03:37 INFO - PROCESS | 1983 | Browser inner width/height: 1024/689 18:03:37 INFO - PROCESS | 1983 | __metrics 18:03:37 INFO - PROCESS | 1983 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:03:37 INFO - PROCESS | 1983 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:03:37 INFO - TEST-INFO | 1983: exit 0 18:03:37 INFO - Browser initialized. 18:03:37 INFO - Running cycle 1/1 for kraken test... 18:03:37 INFO - TEST-INFO | started process 1984 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmp23srQl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:49 INFO - PROCESS | 1984 | RSS: Main: 212619264 18:03:49 INFO - PROCESS | 1984 | 18:03:52 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-beat-detection) 18:03:53 INFO - PROCESS | 1984 | RSS: Main: 265555968 18:03:53 INFO - PROCESS | 1984 | 18:03:56 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-dft) 18:03:56 INFO - PROCESS | 1984 | RSS: Main: 274497536 18:03:56 INFO - PROCESS | 1984 | 18:03:59 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-fft) 18:04:00 INFO - PROCESS | 1984 | RSS: Main: 373137408 18:04:00 INFO - PROCESS | 1984 | 18:04:02 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-oscillator) 18:04:03 INFO - PROCESS | 1984 | RSS: Main: 276217856 18:04:03 INFO - PROCESS | 1984 | 18:04:04 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:04:05 INFO - PROCESS | 1984 | RSS: Main: 278421504 18:04:05 INFO - PROCESS | 1984 | 18:04:08 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-darkroom) 18:04:09 INFO - PROCESS | 1984 | RSS: Main: 318230528 18:04:09 INFO - PROCESS | 1984 | 18:04:11 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-desaturate) 18:04:12 INFO - PROCESS | 1984 | RSS: Main: 318328832 18:04:12 INFO - PROCESS | 1984 | 18:04:15 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49347/tests/kraken/driver.html?testName=json-parse-financial) 18:04:16 INFO - PROCESS | 1984 | RSS: Main: 315494400 18:04:16 INFO - PROCESS | 1984 | 18:04:17 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49347/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:04:18 INFO - PROCESS | 1984 | RSS: Main: 294723584 18:04:18 INFO - PROCESS | 1984 | 18:04:20 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:04:20 INFO - PROCESS | 1984 | RSS: Main: 299593728 18:04:20 INFO - PROCESS | 1984 | 18:04:22 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:04:23 INFO - PROCESS | 1984 | RSS: Main: 300630016 18:04:23 INFO - PROCESS | 1984 | 18:04:26 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:04:27 INFO - PROCESS | 1984 | RSS: Main: 309137408 18:04:27 INFO - PROCESS | 1984 | 18:04:29 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:04:30 INFO - PROCESS | 1984 | RSS: Main: 310325248 18:04:30 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49347/tests/kraken/driver.html?testName=ai-astar) 18:04:32 INFO - PROCESS | 1984 | RSS: Main: 354021376 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | __start_tp_report 18:04:32 INFO - PROCESS | 1984 | _x_x_mozilla_page_load 18:04:32 INFO - PROCESS | 1984 | _x_x_mozilla_page_load_details 18:04:32 INFO - PROCESS | 1984 | |i|pagename|runs| 18:04:32 INFO - PROCESS | 1984 | |0;ai-astar;120;115;114;114;114;114;114;114;113;113 18:04:32 INFO - PROCESS | 1984 | |1;audio-beat-detection;145;110;109;144;111;110;108;110;130;110 18:04:32 INFO - PROCESS | 1984 | |2;audio-dft;183;185;183;185;184;182;183;187;183;185 18:04:32 INFO - PROCESS | 1984 | |3;audio-fft;82;57;57;88;61;59;59;59;73;57 18:04:32 INFO - PROCESS | 1984 | |4;audio-oscillator;88;70;83;65;67;70;83;69;69;83 18:04:32 INFO - PROCESS | 1984 | |5;imaging-gaussian-blur;88;89;135;87;89;85;90;87;89;86 18:04:32 INFO - PROCESS | 1984 | |6;imaging-darkroom;95;94;94;94;95;95;95;95;95;94 18:04:32 INFO - PROCESS | 1984 | |7;imaging-desaturate;84;87;87;89;87;87;85;87;85;87 18:04:32 INFO - PROCESS | 1984 | |8;json-parse-financial;56;54;55;54;54;56;57;56;56;57 18:04:32 INFO - PROCESS | 1984 | |9;json-stringify-tinderbox;73;78;75;76;71;68;67;70;69;71 18:04:32 INFO - PROCESS | 1984 | |10;stanford-crypto-aes;84;83;84;82;83;86;85;85;90;106 18:04:32 INFO - PROCESS | 1984 | |11;stanford-crypto-ccm;142;151;130;138;137;124;137;153;159;146 18:04:32 INFO - PROCESS | 1984 | |12;stanford-crypto-pbkdf2;168;168;169;167;168;173;166;167;166;167 18:04:32 INFO - PROCESS | 1984 | |13;stanford-crypto-sha256-iterative;64;66;68;58;63;69;81;86;85;86 18:04:32 INFO - PROCESS | 1984 | __end_tp_report 18:04:32 INFO - PROCESS | 1984 | __start_cc_report 18:04:32 INFO - PROCESS | 1984 | _x_x_mozilla_cycle_collect,2007 18:04:32 INFO - PROCESS | 1984 | __end_cc_report 18:04:32 INFO - PROCESS | 1984 | __startTimestamp1488593072707__endTimestamp 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | ------- Summary: start ------- 18:04:32 INFO - PROCESS | 1984 | Number of tests: 14 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | [#0] ai-astar Cycles:10 Average:114.50 Median:114.00 stddev:2.01 (1.8%) stddev-sans-first:0.60 18:04:32 INFO - PROCESS | 1984 | Values: 120.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 113.0 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:110.50 stddev:15.02 (13.6%) stddev-sans-first:12.56 18:04:32 INFO - PROCESS | 1984 | Values: 145.0 110.0 109.0 144.0 111.0 110.0 108.0 110.0 130.0 110.0 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:1.49 (0.8%) stddev-sans-first:1.54 18:04:32 INFO - PROCESS | 1984 | Values: 183.0 185.0 183.0 185.0 184.0 182.0 183.0 187.0 183.0 185.0 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | [#3] audio-fft Cycles:10 Average:65.20 Median:60.00 stddev:11.54 (19.2%) stddev-sans-first:10.51 18:04:32 INFO - PROCESS | 1984 | Values: 82.0 57.0 57.0 88.0 61.0 59.0 59.0 59.0 73.0 57.0 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | [#4] audio-oscillator Cycles:10 Average:74.70 Median:76.50 stddev:8.47 (11.1%) stddev-sans-first:7.50 18:04:32 INFO - PROCESS | 1984 | Values: 88.0 70.0 83.0 65.0 67.0 70.0 83.0 69.0 69.0 83.0 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:88.50 stddev:15.01 (17.0%) stddev-sans-first:15.84 18:04:32 INFO - PROCESS | 1984 | Values: 88.0 89.0 135.0 87.0 89.0 85.0 90.0 87.0 89.0 86.0 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:04:32 INFO - PROCESS | 1984 | Values: 95.0 94.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:87.00 stddev:1.43 (1.6%) stddev-sans-first:1.20 18:04:32 INFO - PROCESS | 1984 | Values: 84.0 87.0 87.0 89.0 87.0 87.0 85.0 87.0 85.0 87.0 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.18 (2.1%) stddev-sans-first:1.24 18:04:32 INFO - PROCESS | 1984 | Values: 56.0 54.0 55.0 54.0 54.0 56.0 57.0 56.0 56.0 57.0 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:3.61 (5.0%) stddev-sans-first:3.81 18:04:32 INFO - PROCESS | 1984 | Values: 73.0 78.0 75.0 76.0 71.0 68.0 67.0 70.0 69.0 71.0 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:84.50 stddev:7.10 (8.4%) stddev-sans-first:7.46 18:04:32 INFO - PROCESS | 1984 | Values: 84.0 83.0 84.0 82.0 83.0 86.0 85.0 85.0 90.0 106.0 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:144.00 stddev:10.75 (7.5%) stddev-sans-first:11.40 18:04:32 INFO - PROCESS | 1984 | Values: 142.0 151.0 130.0 138.0 137.0 124.0 137.0 153.0 159.0 146.0 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.00 stddev:2.02 (1.2%) stddev-sans-first:2.15 18:04:32 INFO - PROCESS | 1984 | Values: 168.0 168.0 169.0 167.0 168.0 173.0 166.0 167.0 166.0 167.0 18:04:32 INFO - PROCESS | 1984 | 18:04:32 INFO - PROCESS | 1984 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:75.00 stddev:10.75 (14.3%) stddev-sans-first:10.94 18:04:32 INFO - PROCESS | 1984 | Values: 64.0 66.0 68.0 58.0 63.0 69.0 81.0 86.0 85.0 86.0 18:04:32 INFO - PROCESS | 1984 | -------- Summary: end -------- 18:04:32 INFO - PROCESS | 1984 | 18:04:33 INFO - TEST-INFO | 1984: exit 0 18:04:33 INFO - TEST-OK | kraken | took 58865ms 18:04:33 INFO - SUITE-END | took 1177s 18:04:33 INFO - Completed test suite (00:19:37) 18:04:33 INFO - javascript benchmark 18:04:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.237035481839, 3321.4021476134303, 3343.364760695466, 3368.679975402336, 3398.371301309258, 5602.691851948141, 5647.689377084259, 5668.518175955039, 5691.544676425887, 5695.715214239292, 5529.695866727328, 5660.575456840743, 5688.260526131608, 5688.943110568893, 5695.686737229461, 5162.199859021857, 5164.845054648357, 5228.47715228478, 5229.398619158788, 5280.075986702331, 5120.539151476366, 5130.538251557359, 5284.8150314739, 5301.814436494724, 5325.7869685212545, 4393.648508119359, 5167.173252279636, 5186.766595503193, 5211.0, 5251.606129540281, 5203.271541984125, 5240.973795131038, 5248.842534723926, 5255.474452554714, 5263.157894736823, 5101.923471147936, 5156.535911767922, 5177.663451875616, 5198.766055527511, 5216.765245563959, 5465.726713664301, 5536.584756143306, 5540.0, 5570.6657600543695, 5591.41290164535, 6183.567150299481, 6214.813555593294, 6226.750929962796, 6236.469900058501, 6242.906356404657, 4808.374911261549, 6248.562600617958, 6259.843503912393, 6269.341719119518, 6285.214348206474, 5639.2668953035845, 5645.435456454322, 5685.1756495307945, 5790.565707571906, 5795.391483894173, 6166.414190651881, 6211.503079753609, 6269.122322874801, 6269.65516896566, 6285.371462853769, 6046.365131661112, 6085.604435711664, 6108.450239478469, 6112.572119951649, 6131.478824299985, 6169.444749972524, 6254.093156492283, 6262.405071518198, 6263.0, 6270.0, 5991.9700401498585, 6058.939410605925, 6080.635161890301, 6109.412671190334, 6110.01202914832, 6086.60437071589, 6125.754969801247, 6125.9693701531205, 6148.385161483816, 6158.969205153946, 4926.45808961014, 4961.603071754251, 4974.825881094144, 4979.078870408914, 5000.824971125993, 4445.911081778411, 4454.086912182995, 4457.910841783211, 4459.843905463294, 4467.843625473158, 5598.496135347838, 5655.971720141373, 5671.376148623648, 5693.572982026365, 5718.370979192286, 6185.474234690102, 6230.0, 6247.562670613013, 6304.0, 6331.461825744771, 5719.628224165499, 5767.596288141258, 5770.855728606734, 5789.015867302484, 5824.359320474744, 5160.870978225499, 5199.844004679866, 5412.215228791803, 5414.431484694129, 5433.0763770159165, 6232.999999999909, 6248.094026366242, 6286.308506064421, 6288.905666415099, 6336.493080553452, 6269.74921003173, 6272.4982001440685, 6281.371862813682, 6286.622802631857, 6295.464885484785, 6186.597871138361, 6303.149074874833, 6310.873782524232, 6311.873762524816, 6341.112244285711, 6042.0936859469675, 6104.236970378703, 6111.895622426936, 6211.627302361872, 6227.283862355705, 6183.103449999815, 6285.214348206474, 6287.717052732546, 6290.24517057956, 6292.024736165901, 5026.648134630541, 5227.7453411181805, 6060.969635161945, 6082.574219804571, 6091.42131497507, 5833.300003999547, 5905.202797622438, 6019.217501724747, 6036.154938308729, 6074.939250607437, 5774.0, 5779.306483222041, 5780.104083867007, 5864.589478736448, 5889.440503152194, 5868.501177399969, 5930.762769489172, 6003.279606447254, 6024.216851809237, 6030.065339872327, 5818.214541037075, 5823.068309070529, 5895.793647222326, 5903.173555702291, 5955.047192449188], "value": 5652.275168611087, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.752618533621, 449.16903728102994, 493.7654614058323, 505.07319069507463, 518.1088527732302, 30666.54000189999, 32295.0, 32320.353592928128, 32425.86509472169, 41156.97107572312, 42227.36658950118, 44249.55750442495, 44337.334939975924, 44344.891377715576, 44431.66704998847, 9157.679481218176, 9350.719478415658, 9356.859647105299, 9378.437293762361, 9384.953075234615, 8314.83370332593, 8551.18763717449, 9212.170904618582, 9392.859107113365, 9396.906030939706, 8427.873581896276, 8487.108853570378, 8491.0, 11111.611093611726, 11394.886051139465, 11241.381724005176, 11323.490442930088, 11334.43327833605, 11344.035756960586, 11357.375344356056, 11255.493502792395, 11343.205975581712, 11351.375674337909, 11377.374244416555, 11385.316880987084, 31286.21784455384, 31837.681623183704, 40204.0, 40878.795606022075, 41074.794626026975, 3941.2708648899757, 3948.0773451998402, 3958.9010274743073, 3963.8810835674976, 4043.7573745575064, 29691.554626680616, 30864.228394290098, 31296.21759456009, 31508.36983260345, 32097.6790232097, 3120.8127512349333, 3196.0, 3204.1524218301693, 3229.4832826747606, 3254.3165935153647, 459285.0, 469914.0, 470219.99999999657, 471649.0, 473522.0, 54910.90178196494, 61397.38602614006, 62559.37440625626, 63513.0, 63814.0, 66547.66726166339, 66637.66681166564, 66687.66656166785, 66832.0, 66978.65106744644, 16313.673726525403, 16689.998600084033, 16710.498685039467, 16721.665566688596, 16722.58193545171, 12914.935425323001, 12995.935020325027, 13015.934920325528, 13025.804612930813, 13039.804402933964, 15441.613959650875, 16174.27215775293, 16224.675506489804, 16818.495445136665, 16858.24137913797, 5834.474897259267, 6540.738370465128, 7152.0, 7176.7846964591145, 7211.206767255598, 845.6659619450282, 854.9016863060704, 865.5109862927426, 884.6019291318933, 918.554501066982, 28727.563621818827, 29302.706972930424, 29954.400911982073, 30111.0, 30822.53766193509, 1064.8136576099153, 1073.9570417183224, 1098.9725256868483, 1106.9391183484986, 1174.2250114924109, 14168.858311416754, 14587.635309117357, 14731.705365892622, 14879.776803347959, 15262.313195905988, 595832.0, 622404.0, 624256.0, 626185.0, 626727.0, 54357.0, 54369.728151359785, 54375.6406089843, 54449.72775136099, 54494.45505544973, 1390.8122403475402, 1418.560246323643, 1431.8424973252934, 1439.8776104031274, 1441.4882716635652, 23415.648765268194, 27988.880444781982, 28758.0, 29197.270068248465, 29346.266343341587, 38092.238155236184, 47230.76384618055, 47339.053218934736, 47342.52657473381, 47425.0, 455561.0, 458496.0, 459621.0, 459686.0, 460202.0, 24374.025038998243, 24380.75619243785, 24420.389490262885, 24816.50366992614, 25086.0, 36564.903052908456, 37702.0, 42371.7881410591, 43932.78033609811, 44348.33477497905, 31994.52008219925, 34343.82828085843, 36478.27043459169, 37471.81264093662, 37761.62238377581, 35527.0, 35951.0, 36074.81962590275, 37195.44206836846, 37383.0, 34956.47565286472, 35145.82427087848, 35279.11802204965, 35722.8213858929, 35737.64262357447, 28058.4913855505, 29822.0, 32266.83866580652, 32589.0, 32603.0, 22944.54110917739, 23674.171404000776, 23735.643965340878, 23961.28116156518, 24298.0], "value": 19322.581942126515, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.7571105914333, 394.40051122294113, 401.3838757507227, 401.8794361691492, 425.948886133664, 13496.730065398711, 17356.305747770104, 19772.40682779517, 20944.26695065675, 20952.057157427935, 20853.582928341424, 21132.8943355283, 21200.469988250265, 21638.134474621034, 21996.0, 5191.480851914806, 5565.998120338358, 5689.772409103631, 5691.886162276752, 5705.629134106291, 5441.319835020622, 5562.9443705563035, 5659.745311460994, 5665.1502274658715, 5674.0, 4758.500357462469, 5700.657960522382, 5701.230333904911, 5706.514946229576, 5711.143328500717, 5444.673319600836, 5518.061929471999, 5696.971515142419, 5701.258836351269, 5715.142728590724, 4950.87622809429, 4956.3804524434445, 4960.528749768766, 4964.900701985976, 4973.278874563204, 25365.0, 25685.48629027409, 25878.353041173934, 25986.960521579113, 26085.869570652216, 2308.7575804540447, 2585.767280944724, 2609.9869500652567, 2650.5494066008823, 2691.650085488874, 14918.776218356734, 15301.540953771404, 15655.373785048585, 15767.605809854846, 15904.602384940354, 1734.3314954001842, 1790.516560528663, 1791.552111972007, 1794.3181590995468, 1829.3140072472822, 115031.19625644892, 117583.0, 121433.39283303526, 122337.0, 122643.0, 9838.508074596242, 11366.261193022427, 11435.485403156878, 11896.22674526153, 11899.107566932342, 14313.212773297568, 14884.73479754233, 15477.613059673598, 15663.843361566467, 15686.9215653921, 8261.710840120568, 8705.564721763887, 8889.19997200255, 9031.729048128567, 9080.8637870432, 8561.143885611513, 8561.571921403905, 8721.694740684046, 8793.956030219935, 8824.77938051541, 4833.830815921426, 4855.1260773060485, 4863.10032643962, 4863.756812159378, 4941.901161976741, 2008.3974807557674, 2049.7540295164677, 2052.969205461919, 2056.3830850744716, 2056.814886660208, 855.6149732620346, 1014.7564584499667, 1026.8973102689672, 1036.0934182590233, 1043.5721354244724, 21115.788842111688, 21549.138034478445, 21828.0, 22021.779782202295, 22105.115795368005, 872.8952525696957, 1018.6587493189865, 1043.7599352149048, 1049.464772965793, 1062.4528367890543, 10929.0, 11342.262752921033, 11414.885851141382, 11487.483063262172, 11587.073034157247, 754602.0, 762134.1893290608, 769034.0, 788781.0, 788973.0, 146551.0, 147662.26168869087, 150328.49671503145, 150483.0, 150585.0, 1000.5497526113278, 1014.9695509134738, 1034.3535290443472, 1038.8078205532001, 1049.2917280835559, 18628.0, 19099.14053867607, 19336.709949351054, 19350.612987739885, 19440.0, 54995.72502137464, 59663.701681491315, 60149.49626259204, 60243.39756602378, 61389.0, 82308.0, 84085.0, 84257.0, 84659.5767021161, 85805.0, 7976.960115199387, 8282.337413007066, 8547.95726021366, 8611.397202195787, 8747.562621868754, 9100.499472529074, 13243.80134297967, 13833.930830346186, 13855.722885542435, 13926.860731392962, 11309.377984210947, 11352.148588855704, 11457.885421145682, 11805.0, 11849.703757406134, 11416.372099534605, 11439.542418303176, 11712.472938717949, 11909.987651049758, 11952.223105498115, 6059.818205453844, 7505.8498830022, 11509.446224759551, 11645.301281923112, 12092.455839487067, 8340.374471914509, 8453.95773021131, 8569.314454843472, 8612.48325100496, 8648.005479369953, 9005.954970225106, 9122.407043542149, 11555.480003400035, 11857.822132667845, 11900.523979040741], "value": 9939.825273010436, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.4904009076777, 1438.5340084959055, 1440.6902515959066, 1459.7226526959878, 1459.8029266049084, 8045.718399856006, 8513.53175575343, 8521.105283945182, 8521.957390213049, 8527.573621318925, 7405.074365704287, 7646.885296720554, 7655.464117511762, 7997.6001199940065, 8284.295834854045, 2291.186628746796, 2329.860208387502, 2334.9299521014314, 2337.298810356886, 2340.8127349811975, 2299.5630830142304, 2324.6396808494624, 2350.5416443793465, 2357.457784709518, 2361.822863285252, 2335.1359996801207, 2343.179887039531, 2362.692849929507, 2369.6327069304284, 2369.656399822025, 2284.291869520454, 2287.553926984239, 2312.4450131968374, 2312.456572705413, 2316.872572008539, 1981.7522809648794, 2324.779145981129, 2352.6235802271726, 2356.599378105726, 2357.6463530470396, 8225.341972642174, 8369.623366948503, 8378.287845533137, 8380.497170169809, 8380.8742868857, 4991.5258050485145, 5143.974280128613, 5154.536091751723, 5156.407013193493, 5191.091558977164, 2967.3471836196004, 3283.8522266497826, 3303.0751389610946, 3424.1610805352598, 3487.825608719579, 1005.6480231918842, 1152.573547787324, 1166.2710805746408, 1211.9757604847941, 1214.8602910665297, 10549.050585447423, 10570.048695617354, 10689.984451477098, 10725.570977160904, 10745.731356716067, 4446.244138496463, 4583.243764778841, 4666.230072038075, 4680.976595117071, 4726.149293127201, 9508.429494230368, 9512.38169518979, 9521.90478095224, 9542.33203675736, 9624.326297159132, 5220.347456567929, 5221.425643179247, 5221.477852214824, 5222.294990176353, 5225.111731005738, 4096.119334343071, 4362.476502819682, 4624.97687511567, 4724.244120940702, 4758.714477131383, 3823.7323387362617, 3853.8651147210276, 3958.3072962231495, 3973.6026397360033, 3994.0414300568236, 1104.8563686720674, 1147.4549588945183, 1244.1788419642992, 1275.5854347337151, 1299.4802079168408, 652.2824892618082, 744.7989042958371, 750.5121670913841, 791.9802004949807, 824.9010118785784, 5152.742362881841, 5382.3541175059245, 5574.804881829116, 5629.7185140742795, 5639.689817060019, 466.42163716991365, 466.5637628817067, 570.848725087852, 571.5856004396779, 577.209223363994, 3116.2209447638093, 3554.1647712787476, 3568.518250036264, 3641.1807343347537, 3673.9265214696093, 9362.765930851783, 9865.260105492116, 9882.407055576545, 9893.15908147801, 9919.553620086968, 9694.0, 9841.852372214422, 9842.901570984342, 9844.901550984541, 9865.605375784888, 7521.586312752742, 7629.427792915553, 7669.348105410991, 7774.2614451627005, 7789.1042530108625, 5255.763490642854, 5362.302900622894, 5465.699386533779, 5551.944480555143, 5651.0, 8957.955210224169, 8977.685780997634, 9046.90953090487, 9076.863847042168, 9152.771180720536, 8768.342374321825, 9309.906900931175, 9318.627254909728, 9325.114114159143, 9360.906390936003, 6581.473482121323, 6800.0, 7126.821829454305, 7216.0, 7224.313690199423, 7469.477136600603, 7470.2903224193615, 7614.124375696866, 7705.884411733717, 7810.336121429742, 6716.227633821977, 6792.0830687856505, 6808.489363297674, 6850.45196384298, 6941.722331106699, 6431.260405053292, 6462.579932304385, 6480.416762491398, 6480.773172938924, 6508.544401891822, 6241.812745617639, 6284.811455656338, 6310.842228944313, 6315.684215789284, 6332.30344662096, 4753.429588449409, 4761.76191190446, 4799.352087468147, 4906.975465122651, 5028.195488721787, 4884.682495637772, 4917.237828136645, 4955.058538877746, 4977.979514199508, 4993.750312484434], "value": 4271.134054150918, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.20304315290593, 357.24977547150985, 362.5685434333144, 374.5299648940579, 375.71633416770334, 4838.225883858583, 4969.229769385751, 5008.672701734044, 5105.4894510548975, 5479.328804714561, 4261.487172053923, 4576.725396476206, 4628.62970962323, 5039.41258503572, 5234.162533994561, 3658.3414985302634, 4102.5897410258885, 4186.183694179636, 4193.454850869382, 4210.557891421403, 4154.729942553739, 4170.9582904170875, 4177.3499467710235, 4178.7283826551175, 4256.531781504032, 3281.409346317662, 3778.7530115061963, 3976.443297938291, 4169.291220492509, 4192.517860446042, 3385.881494147693, 3969.8412063517567, 4103.13834094839, 4126.896827579305, 4156.521999969982, 2891.580720795473, 3668.394714872043, 3685.3366394049062, 3686.9078273043388, 3696.8706095286807, 4000.159966407029, 5172.870678233036, 5186.662866913639, 5196.45437229093, 5213.187296164749, 4570.748608826513, 4799.352087468217, 4805.543473370024, 4816.349792777965, 4824.855254342376, 4261.0, 4661.207594708908, 5321.627486075976, 5621.606487545873, 5631.943680563183, 4068.430419741209, 4080.0411903202726, 4093.97953010236, 4102.815373308178, 4109.732867363612, 4830.516948305177, 5020.59835213182, 5196.842525979201, 5927.762889484372, 5984.0, 3553.596329449853, 3724.031751744512, 3841.8891785789497, 3853.0734632683657, 3853.5915053091817, 3396.864125434955, 3877.9917221522605, 3923.7449565778134, 3926.0, 3948.8617898373996, 3981.5222173338807, 4359.716618419792, 4550.749708765983, 4560.543945605413, 4610.884727881829, 5200.5059519345605, 5669.569910204267, 5696.943030569724, 5700.377826199911, 5709.316621188035, 1266.7719810434025, 1277.9424925878172, 1286.247545186058, 1286.75551645189, 1294.1558279451745, 681.8840797064511, 738.7931379213828, 808.6441965535263, 812.524673066251, 864.5979619476848, 4260.825684864795, 4501.8295243237, 4594.1730488512385, 4660.557247061523, 4938.728369939688, 4719.9292010619865, 4861.319415281863, 5437.782488700487, 5449.591280653967, 5556.91664625031, 4537.478190008192, 4546.499885012646, 4601.861944141681, 4750.786214620351, 4981.227909674007, 2276.499170182557, 2749.257700420915, 2855.1862719125365, 2873.8994135205166, 2881.4381195667065, 4893.584045356113, 5191.5846732261325, 5572.4706152916215, 5787.305523337226, 5794.130880367894, 4603.0, 4801.279808028824, 4840.184930651006, 4874.683145595525, 5423.291663126102, 4973.159930825545, 5178.818741344035, 5522.530584900248, 5752.7698892043845, 5822.94177058241, 5426.918596220981, 5494.642848214853, 5499.395066542757, 5563.7496312666835, 5575.330960284792, 5311.973440132929, 5770.422957704196, 5834.474897259267, 5854.707264636836, 5867.125108696793, 6063.969680151571, 6125.050617154348, 6133.754649813957, 6134.171886795226, 6177.227846519185, 3942.5466071402157, 4127.628513433805, 4191.937120943127, 4266.168097221012, 4290.1419716057535, 4385.890352741207, 5286.7356632169, 5791.623544469596, 5817.156512305776, 5818.098194779646, 4173.791310434527, 4761.857154283017, 5295.808443100272, 5544.500994910478, 5692.231548740867, 4855.854324370274, 4865.318855360181, 5172.250023746611, 5673.716314184357, 5723.8855222896145, 4984.775685094107, 5228.032813929435, 5534.418886017072, 5600.69196194197, 5628.549716022791, 5195.246689230116, 5443.482869127585, 5515.503604675599, 5560.883986732297, 5587.429782300025, 5472.808451704172, 5475.945240547703, 5495.0, 5520.466901183327, 5527.429745168516], "value": 4034.9109908081664, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.4037716997627, 710.2187593646986, 734.6290123487638, 793.1592511937347, 805.5690205739928, 14349.426022959082, 15386.307616157272, 15452.69094618107, 15467.917245792785, 15471.613209669764, 13579.388927498261, 13757.724845503084, 14045.92977035116, 14054.086484378508, 14162.150270983748, 666.6766618190198, 686.2519853359837, 828.3538839705025, 842.1662554071456, 849.1890244816186, 683.794861541538, 810.7040930060544, 837.4514692876145, 837.7361131243639, 840.3403328387217, 883.4213590098495, 896.7847716548014, 897.2373482539854, 899.4423457456386, 900.4867225681331, 893.9150780675825, 894.8434024045798, 894.8612964990436, 894.8791913091715, 894.8836651235363, 517.8550005998327, 532.1113740054119, 535.5126834580552, 663.4294506724214, 666.4235436347525, 12518.74962500754, 12565.371731413485, 14002.789958150635, 14527.273636318141, 14546.199959002251, 10826.350418974887, 11655.417229138595, 11766.941165294204, 13250.536231231958, 13474.663133421645, 11124.332540047622, 11574.189806713533, 11712.0, 11781.293122412682, 11930.463129159209, 3655.524781778352, 3710.666040056408, 3730.720195985312, 3756.586775454698, 3861.517310336208, 107467.0, 107946.99999999921, 108836.4558177212, 112770.43614781955, 112993.0, 10662.786744265071, 10813.945930270298, 10890.72773180661, 10949.397783122005, 10964.122870170368, 21459.712417255014, 22257.55484890293, 22411.551768964528, 22520.0, 22548.549029019327, 7100.000499577848, 7109.786706398816, 7145.535540189871, 7178.928210717826, 7203.963980180066, 4161.542230354658, 4264.850730224489, 4288.952517298927, 4365.563443655673, 4437.534058923767, 3531.434970404723, 3600.7479476436397, 3601.081724160322, 3606.2426890353318, 3640.690541304019, 625.1435533319382, 642.82322361351, 646.0986923242145, 653.6111013946694, 661.890788019981, 536.940936496985, 609.3479976425272, 675.2268652392983, 688.3013741052836, 692.3803196139427, 9879.0, 10028.548715307828, 10717.83923241152, 10879.0, 11208.887911120784, 593.2673148661399, 598.984417435327, 604.7732100462326, 613.3743581546797, 720.8522252938135, 4646.744429056367, 4870.902581948341, 4990.426100998359, 5005.649604527721, 5007.924881126786, 104032.0, 104045.0, 104382.0, 104828.95171048344, 105906.0, 57474.5631359211, 76881.0, 76969.0, 82655.17344826474, 84457.0, 73057.0, 75901.0, 77857.221427785, 78821.81767273495, 79344.0, 10173.28786984904, 10551.419671918118, 10698.946505267424, 10707.678769636923, 10761.946190268998, 47907.083716652334, 48372.162783721345, 48820.0, 48909.2663610039, 50103.0, 63655.0, 67103.32896670971, 67245.0, 69095.0, 70055.237571546, 10830.350178989285, 12126.787321267802, 13068.477260909458, 13376.799348009983, 13455.86544134546, 14153.646158845699, 14603.415863365346, 15161.09033457996, 15203.31585078652, 15287.312070957056, 13116.934415327862, 13666.0, 13931.930340348234, 13988.440462381797, 14344.924130690031, 13293.0, 13339.399727012114, 13947.442102315794, 13956.79064814049, 14423.855761442252, 12374.443150058089, 13261.469541218243, 13497.662558436117, 13601.727965440834, 13955.372008259856, 10377.481125943823, 11014.669559913216, 11170.497327620114, 11219.887801121884, 11415.315081095161, 10091.19270458347, 10539.78920421572, 10965.61620343284, 10967.670969870916, 11002.559897604006], "value": 7354.8294688985125, "unit": "score"}], "name": "dromaeo_css", "value": 7185.289636530842, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 109.0, 144.0, 111.0, 110.0, 108.0, 110.0, 130.0, 110.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 183.0, 185.0, 184.0, 182.0, 183.0, 187.0, 183.0, 185.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 57.0, 57.0, 88.0, 61.0, 59.0, 59.0, 59.0, 73.0, 57.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 83.0, 65.0, 67.0, 70.0, 83.0, 69.0, 69.0, 83.0], "value": 74.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 135.0, 87.0, 89.0, 85.0, 90.0, 87.0, 89.0, 86.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 87.0, 89.0, 87.0, 87.0, 85.0, 87.0, 85.0, 87.0], "value": 86.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 54.0, 54.0, 56.0, 57.0, 56.0, 56.0, 57.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 75.0, 76.0, 71.0, 68.0, 67.0, 70.0, 69.0, 71.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 82.0, 83.0, 86.0, 85.0, 85.0, 90.0, 106.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 151.0, 130.0, 138.0, 137.0, 124.0, 137.0, 153.0, 159.0, 146.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 169.0, 167.0, 168.0, 173.0, 166.0, 167.0, 166.0, 167.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 68.0, 58.0, 63.0, 69.0, 81.0, 86.0, 85.0, 86.0], "value": 72.6, "unit": "score"}], "name": "kraken", "value": 1427.0, "alertThreshold": 2.0}]} 18:04:33 INFO - Return code: 0 18:04:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:04:33 ERROR - # TBPL SUCCESS # 18:04:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:04:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:04:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:04:34 INFO - 2017-03-03 18:04:34.006 screenresolution[1988:15060] starting screenresolution argv=screenresolution get 18:04:34 INFO - 2017-03-03 18:04:34.009 screenresolution[1988:15060] Display 0: 1600x1200x32@60 18:04:34 INFO - 2017-03-03 18:04:34.015 screenresolution[1989:15063] starting screenresolution argv=screenresolution list 18:04:34 INFO - Available Modes on Display 0 18:04:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:04:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:04:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:04:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:04:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:04:34 INFO - Intel Iris: 18:04:34 INFO - Chipset Model: Intel Iris 18:04:34 INFO - Type: GPU 18:04:34 INFO - Bus: Built-In 18:04:34 INFO - VRAM (Dynamic, Max): 1536 MB 18:04:34 INFO - Vendor: Intel (0x8086) 18:04:34 INFO - Device ID: 0x0a2e 18:04:34 INFO - Revision ID: 0x0009 18:04:34 INFO - Displays: 18:04:34 INFO - Display: 18:04:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:04:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:04:34 INFO - Display Serial Number: 1600x1200 60 18:04:34 INFO - Main Display: Yes 18:04:34 INFO - Mirror: Off 18:04:34 INFO - Online: Yes 18:04:34 INFO - Rotation: Supported 18:04:34 INFO - Return code: 0 18:04:34 INFO - Running post-action listener: _resource_record_post_action 18:04:34 INFO - [mozharness: 2017-03-04 02:04:34.253935Z] Finished run-tests step (success) 18:04:34 INFO - Running post-run listener: _resource_record_post_run 18:04:34 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 339968; Write bytes: 507473408; Read time: 4; Write time: 1943 18:04:34 INFO - TinderboxPrint: CPU usage
53.5% 18:04:34 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 4 18:04:34 INFO - TinderboxPrint: I/O write bytes / time
507,473,408 / 1,943 18:04:34 INFO - TinderboxPrint: CPU idle
2,229.4 (46.5%) 18:04:34 INFO - TinderboxPrint: CPU system
952.3 (19.9%) 18:04:34 INFO - TinderboxPrint: CPU user
1,612.0 (33.6%) 18:04:34 INFO - TinderboxPrint: Swap in / out
207,781,888 / 0 18:04:34 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205462016; Write bytes: 200562176; Read time: 15648; Write time: 380 18:04:34 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 262144; Write bytes: 295864320; Read time: 3; Write time: 1526 18:04:34 INFO - Running post-run listener: _upload_blobber_files 18:04:34 INFO - Blob upload gear active. 18:04:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:04:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:04:34 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:04:34 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:04:35 INFO - (blobuploader) - INFO - Open directory for files ... 18:04:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:04:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:04:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:36 INFO - (blobuploader) - INFO - Done attempting. 18:04:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:04:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:04:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:37 INFO - (blobuploader) - INFO - Done attempting. 18:04:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:04:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:04:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:38 INFO - (blobuploader) - INFO - Done attempting. 18:04:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:04:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:04:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:40 INFO - (blobuploader) - INFO - Done attempting. 18:04:40 INFO - (blobuploader) - INFO - Iteration through files over. 18:04:40 INFO - Return code: 0 18:04:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:04:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:04:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/949fd192dc09868bc475fcdb38fd6870560ee8e66cc7617019d52dcbc7bef51d75886ea2696bd54c9bb0243a096796fece7f4301431998e2c83d7c9b90a256b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bf15179d57ef0f3308b784924e857964396e5e2eab8d3389d02830f046cf3cb69ecf23d62f16229f789a571cd8cee5f767d28fb44efb3438768ffe66ad55360", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/477bcf31768d01d6e4e858499ceacb1cd49112c08ea9d3532501e37ee864706596bf4d7c80484a9ee80667a91fa3645f9358f155ba07adef5192c2f0000a4fea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/207b7ee3f54b06e086c006e282e540ddf4393b2d6b80468fd4a7133a25bf4c09fe70bc759666b0b7bde646e7c727fc338bf95cec3b15c6eeb917f08d8fc16673"} 18:04:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:04:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:04:40 INFO - Contents: 18:04:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/949fd192dc09868bc475fcdb38fd6870560ee8e66cc7617019d52dcbc7bef51d75886ea2696bd54c9bb0243a096796fece7f4301431998e2c83d7c9b90a256b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bf15179d57ef0f3308b784924e857964396e5e2eab8d3389d02830f046cf3cb69ecf23d62f16229f789a571cd8cee5f767d28fb44efb3438768ffe66ad55360", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/477bcf31768d01d6e4e858499ceacb1cd49112c08ea9d3532501e37ee864706596bf4d7c80484a9ee80667a91fa3645f9358f155ba07adef5192c2f0000a4fea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/207b7ee3f54b06e086c006e282e540ddf4393b2d6b80468fd4a7133a25bf4c09fe70bc759666b0b7bde646e7c727fc338bf95cec3b15c6eeb917f08d8fc16673"} 18:04:40 INFO - Running post-run listener: copy_logs_to_upload_dir 18:04:40 INFO - Copying logs to upload dir... 18:04:40 INFO - mkdir: /builds/slave/test/build/upload/logs 18:04:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.058200 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-03 18:04:40.453968) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 18:04:40.457184) ========= 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.SjjlJhW6fq/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.fAjwm7NhbL/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-Aurora/sha512/949fd192dc09868bc475fcdb38fd6870560ee8e66cc7617019d52dcbc7bef51d75886ea2696bd54c9bb0243a096796fece7f4301431998e2c83d7c9b90a256b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bf15179d57ef0f3308b784924e857964396e5e2eab8d3389d02830f046cf3cb69ecf23d62f16229f789a571cd8cee5f767d28fb44efb3438768ffe66ad55360", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/477bcf31768d01d6e4e858499ceacb1cd49112c08ea9d3532501e37ee864706596bf4d7c80484a9ee80667a91fa3645f9358f155ba07adef5192c2f0000a4fea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/207b7ee3f54b06e086c006e282e540ddf4393b2d6b80468fd4a7133a25bf4c09fe70bc759666b0b7bde646e7c727fc338bf95cec3b15c6eeb917f08d8fc16673"} build_url:https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/949fd192dc09868bc475fcdb38fd6870560ee8e66cc7617019d52dcbc7bef51d75886ea2696bd54c9bb0243a096796fece7f4301431998e2c83d7c9b90a256b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bf15179d57ef0f3308b784924e857964396e5e2eab8d3389d02830f046cf3cb69ecf23d62f16229f789a571cd8cee5f767d28fb44efb3438768ffe66ad55360", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/477bcf31768d01d6e4e858499ceacb1cd49112c08ea9d3532501e37ee864706596bf4d7c80484a9ee80667a91fa3645f9358f155ba07adef5192c2f0000a4fea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/207b7ee3f54b06e086c006e282e540ddf4393b2d6b80468fd4a7133a25bf4c09fe70bc759666b0b7bde646e7c727fc338bf95cec3b15c6eeb917f08d8fc16673"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 18:04:40.493878) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:04:40.494255) ========= 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.SjjlJhW6fq/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.fAjwm7NhbL/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.005402 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:04:40.543477) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 18:04:40.543800) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 18:04:40.544117) ========= ========= Total master_lag: 0.18 =========