builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0353 starttime: 1491348507.55 results: success (0) buildid: 20170404153430 builduid: a0857b3095c24f4886b14163a31b6d4b revision: 41323426061e6cd60125b5f0728442faca1cbe60 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 16:28:27.550295) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 16:28:27.550729) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-04-04 16:28:27.551139) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-04-04 16:28:30.781530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 16:28:30.781845) ========= 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.a6eQNYR9lx/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.Suxmwzu5fP/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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-04-04 16:28:30-- 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% 19.3M=0.001s 2017-04-04 16:28:30 (19.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104651 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 16:28:30.983052) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 16:28:30.983386) ========= 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.a6eQNYR9lx/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.Suxmwzu5fP/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.027094 ========= master_lag: 0.50 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 16:28:31.506958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 16:28:31.507275) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 41323426061e6cd60125b5f0728442faca1cbe60 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 41323426061e6cd60125b5f0728442faca1cbe60 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a6eQNYR9lx/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.Suxmwzu5fP/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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-04-04 16:28:31,615 truncating revision to first 12 chars 2017-04-04 16:28:31,615 Setting DEBUG logging. 2017-04-04 16:28:31,616 attempt 1/10 2017-04-04 16:28:31,616 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/41323426061e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 16:28:32,291 unpacking tar archive at: mozilla-beta-41323426061e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.950080 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 16:28:32.484955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 16:28:32.485249) ========= script_repo_revision: 41323426061e6cd60125b5f0728442faca1cbe60 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 16:28:32.485640) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 16:28:32.485923) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 16:28:32.506248) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-04-04 16:28:32.506542) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a6eQNYR9lx/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.Suxmwzu5fP/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 16:28:32 INFO - MultiFileLogger online at 20170404 16:28:32 in /builds/slave/test 16:28:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:28:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:28:32 INFO - {'append_to_log': False, 16:28:32 INFO - 'base_work_dir': '/builds/slave/test', 16:28:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:28:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:28:32 INFO - 'branch': 'Mozilla-Beta', 16:28:32 INFO - 'buildbot_json_path': 'buildprops.json', 16:28:32 INFO - 'config_files': ('talos/mac_config.py',), 16:28:32 INFO - 'default_actions': ('clobber', 16:28:32 INFO - 'read-buildbot-config', 16:28:32 INFO - 'download-and-extract', 16:28:32 INFO - 'populate-webroot', 16:28:32 INFO - 'create-virtualenv', 16:28:32 INFO - 'install', 16:28:32 INFO - 'run-tests'), 16:28:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:28:32 INFO - 'download_minidump_stackwalk': True, 16:28:32 INFO - 'download_symbols': 'ondemand', 16:28:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:28:32 INFO - 'tooltool.py': '/tools/tooltool.py', 16:28:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:28:32 INFO - '/tools/misc-python/virtualenv.py')}, 16:28:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:28:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:28:32 INFO - 'installer_path': 'installer.exe', 16:28:32 INFO - 'log_level': 'info', 16:28:32 INFO - 'log_name': 'talos', 16:28:32 INFO - 'log_to_console': True, 16:28:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:28:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:28:32 INFO - 'opt_config_files': (), 16:28:32 INFO - 'pip_index': False, 16:28:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:28:32 INFO - 'cmd': ('bash', 16:28:32 INFO - '-c', 16:28:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:28:32 INFO - 'enabled': True, 16:28:32 INFO - 'halt_on_failure': False, 16:28:32 INFO - 'name': 'check_screen_resolution'},), 16:28:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:28:32 INFO - 'cmd': ('bash', 16:28:32 INFO - '-c', 16:28:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:28:32 INFO - 'enabled': True, 16:28:32 INFO - 'halt_on_failure': False, 16:28:32 INFO - 'name': 'check_screen_resolution'},), 16:28:32 INFO - 'run_cmd_checks_enabled': True, 16:28:32 INFO - 'sps_profile': False, 16:28:32 INFO - 'sps_profile_interval': 0, 16:28:32 INFO - 'suite': 'dromaeojs', 16:28:32 INFO - 'system_bits': '32', 16:28:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:28:32 INFO - 'title': 't-yosemite-r7-0353', 16:28:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:28:32 INFO - 'use_talos_json': True, 16:28:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:28:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:28:32 INFO - 'work_dir': 'build'} 16:28:32 INFO - [mozharness: 2017-04-04 23:28:32.724618Z] Running clobber step. 16:28:32 INFO - Running pre-action listener: _resource_record_pre_action 16:28:32 INFO - Running main action method: clobber 16:28:32 INFO - rmtree: /builds/slave/test/build 16:28:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:28:35 INFO - Running post-action listener: _resource_record_post_action 16:28:35 INFO - [mozharness: 2017-04-04 23:28:35.128024Z] Finished clobber step (success) 16:28:35 INFO - [mozharness: 2017-04-04 23:28:35.128192Z] Running read-buildbot-config step. 16:28:35 INFO - Running pre-action listener: _resource_record_pre_action 16:28:35 INFO - Running main action method: read_buildbot_config 16:28:35 INFO - Using buildbot properties: 16:28:35 INFO - { 16:28:35 INFO - "project": "", 16:28:35 INFO - "product": "firefox", 16:28:35 INFO - "script_repo_revision": "production", 16:28:35 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 16:28:35 INFO - "repository": "", 16:28:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 16:28:35 INFO - "buildid": "20170404153430", 16:28:35 INFO - "pgo_build": "False", 16:28:35 INFO - "basedir": "/builds/slave/test", 16:28:35 INFO - "buildnumber": 18, 16:28:35 INFO - "slavename": "t-yosemite-r7-0353", 16:28:35 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 16:28:35 INFO - "platform": "yosemite_r7", 16:28:35 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:28:35 INFO - "branch": "mozilla-beta", 16:28:35 INFO - "repo_path": "releases/mozilla-beta", 16:28:35 INFO - "revision": "41323426061e6cd60125b5f0728442faca1cbe60", 16:28:35 INFO - "stage_platform": "macosx64", 16:28:35 INFO - "builduid": "a0857b3095c24f4886b14163a31b6d4b", 16:28:35 INFO - "slavebuilddir": "test" 16:28:35 INFO - } 16:28:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 16:28:35 INFO - Running post-action listener: _resource_record_post_action 16:28:35 INFO - [mozharness: 2017-04-04 23:28:35.131418Z] Finished read-buildbot-config step (success) 16:28:35 INFO - [mozharness: 2017-04-04 23:28:35.131564Z] Running download-and-extract step. 16:28:35 INFO - Running pre-action listener: _resource_record_pre_action 16:28:35 INFO - Running main action method: download_and_extract 16:28:35 INFO - mkdir: /builds/slave/test/build/tests 16:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:35 INFO - trying https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 16:28:35 INFO - Downloading https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 16:28:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 16:28:35 INFO - Downloaded 1165 bytes. 16:28:35 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 16:28:35 INFO - Using the following test package requirements: 16:28:35 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 16:28:35 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:28:35 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 16:28:35 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:28:35 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 16:28:35 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:28:35 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:28:35 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 16:28:35 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 16:28:35 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:28:35 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 16:28:35 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:28:35 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 16:28:35 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:28:35 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 16:28:35 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:28:35 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 16:28:35 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 16:28:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 16:28:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 16:28:35 INFO - Fetch https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 16:28:36 INFO - Expected file size: 16116743 16:28:36 INFO - Obtained file size: 16116743 16:28:43 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 16:28:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 16:28:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 16:28:43 INFO - Fetch https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 16:28:44 INFO - Expected file size: 16116743 16:28:44 INFO - Obtained file size: 16116743 16:28:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 16:28:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 16:28:50 INFO - Fetch https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 16:28:52 INFO - Expected file size: 14403663 16:28:52 INFO - Obtained file size: 14403663 16:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:52 INFO - trying https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:28:52 INFO - Downloading https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 16:28:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 16:28:54 INFO - Downloaded 58740468 bytes. 16:28:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:28:54 INFO - mkdir: /builds/slave/test/properties 16:28:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:28:54 INFO - Writing to file /builds/slave/test/properties/build_url 16:28:54 INFO - Contents: 16:28:54 INFO - build_url:https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:28:54 INFO - Running post-action listener: _resource_record_post_action 16:28:54 INFO - Running post-action listener: set_extra_try_arguments 16:28:54 INFO - [mozharness: 2017-04-04 23:28:54.791576Z] Finished download-and-extract step (success) 16:28:54 INFO - [mozharness: 2017-04-04 23:28:54.791723Z] Running populate-webroot step. 16:28:54 INFO - Running pre-action listener: _resource_record_pre_action 16:28:54 INFO - Running main action method: populate_webroot 16:28:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:28:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:28:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:28:54 INFO - '--tppagecycles', 16:28:54 INFO - '7'], 16:28:54 INFO - 'tests': ['tsvgm']}}, 16:28:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:28:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:28:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:28:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:28:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:28:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:28:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:28:54 INFO - 'talos_options': ['--disable-e10s'], 16:28:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:28:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:28:54 INFO - 'talos_options': ['--disable-e10s'], 16:28:54 INFO - 'tests': ['damp', 'tps']}, 16:28:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:28:54 INFO - 'tests': ['damp', 'tps']}, 16:28:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:28:54 INFO - 'tests': ['dromaeo_dom']}, 16:28:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:28:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:28:54 INFO - 'tests': ['basic_compositor_video']}, 16:28:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:28:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:28:54 INFO - 'tests': ['a11yr', 16:28:54 INFO - 'ts_paint', 16:28:54 INFO - 'tpaint', 16:28:54 INFO - 'sessionrestore', 16:28:54 INFO - 'sessionrestore_no_auto_restore', 16:28:54 INFO - 'tabpaint']}, 16:28:54 INFO - 'other-e10s': {'tests': ['a11yr', 16:28:54 INFO - 'ts_paint', 16:28:54 INFO - 'tpaint', 16:28:54 INFO - 'sessionrestore', 16:28:54 INFO - 'sessionrestore_no_auto_restore', 16:28:54 INFO - 'tabpaint']}, 16:28:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:28:54 INFO - 'ts_paint', 16:28:54 INFO - 'tpaint', 16:28:54 INFO - 'sessionrestore', 16:28:54 INFO - 'sessionrestore_no_auto_restore', 16:28:54 INFO - 'tabpaint']}, 16:28:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:28:54 INFO - 'ts_paint', 16:28:54 INFO - 'tpaint', 16:28:54 INFO - 'sessionrestore', 16:28:54 INFO - 'sessionrestore_no_auto_restore', 16:28:54 INFO - 'tabpaint']}, 16:28:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:28:54 INFO - 'tests': ['a11yr', 16:28:54 INFO - 'ts_paint', 16:28:54 INFO - 'tpaint', 16:28:54 INFO - 'sessionrestore', 16:28:54 INFO - 'sessionrestore_no_auto_restore', 16:28:54 INFO - 'tabpaint']}, 16:28:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:28:54 INFO - 'tests': ['a11yr', 16:28:54 INFO - 'ts_paint', 16:28:54 INFO - 'tpaint', 16:28:54 INFO - 'sessionrestore', 16:28:54 INFO - 'sessionrestore_no_auto_restore', 16:28:54 INFO - 'tabpaint']}, 16:28:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:28:54 INFO - 'tests': ['tsvgx', 16:28:54 INFO - 'tsvgr_opacity', 16:28:54 INFO - 'tart', 16:28:54 INFO - 'tscrollx', 16:28:54 INFO - 'cart', 16:28:54 INFO - 'tsvg_static']}, 16:28:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:28:54 INFO - 'tsvgr_opacity', 16:28:54 INFO - 'tart', 16:28:54 INFO - 'tscrollx', 16:28:54 INFO - 'cart', 16:28:54 INFO - 'tsvg_static']}, 16:28:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:28:54 INFO - 'talos_options': ['--disable-e10s'], 16:28:54 INFO - 'tests': ['tp5o']}, 16:28:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:28:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:28:54 INFO - 'talos_options': ['--disable-e10s', 16:28:54 INFO - '--xperf_path', 16:28:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:54 INFO - 'tests': ['tp5n']}, 16:28:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:28:54 INFO - 'talos_options': ['--xperf_path', 16:28:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:54 INFO - 'tests': ['tp5n']}}, 16:28:54 INFO - 'talos.zip': {'path': '', 16:28:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:28:54 INFO - Running post-action listener: _resource_record_post_action 16:28:54 INFO - [mozharness: 2017-04-04 23:28:54.811095Z] Finished populate-webroot step (success) 16:28:54 INFO - [mozharness: 2017-04-04 23:28:54.811207Z] Running create-virtualenv step. 16:28:54 INFO - Running pre-action listener: _resource_record_pre_action 16:28:54 INFO - Running main action method: create_virtualenv 16:28:54 INFO - Creating virtualenv /builds/slave/test/build/venv 16:28:54 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 16:28:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:28:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:28:54 INFO - Using real prefix '/tools/python27' 16:28:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:28:55 INFO - Installing distribute.............................................................................................................................................................................................done. 16:28:58 INFO - Installing pip.................done. 16:28:58 INFO - Return code: 0 16:28:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:28:58 INFO - Reading from file tmpfile_stdout 16:28:58 INFO - Output received: 16:28:58 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) 16:28:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:28:58 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')]} 16:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:58 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')]} 16:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:58 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 0x10c13ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c13d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f81c5c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf18d30>, '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 0x10be3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf0dbe8>, '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.a6eQNYR9lx/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.Suxmwzu5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 16:28:58 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 16:28:58 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 16:28:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a6eQNYR9lx/Render', 16:28:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:58 INFO - 'HOME': '/Users/cltbld', 16:28:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:58 INFO - 'LOGNAME': 'cltbld', 16:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:58 INFO - 'MOZ_NO_REMOTE': '1', 16:28:58 INFO - 'NO_EM_RESTART': '1', 16:28:58 INFO - 'PAGER': '/bin/cat', 16:28:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:58 INFO - 'PWD': '/builds/slave/test', 16:28:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:58 INFO - 'SHELL': '/bin/bash', 16:28:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Suxmwzu5fP/Listeners', 16:28:58 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 16:28:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:58 INFO - 'USER': 'cltbld', 16:28:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:58 INFO - 'XPC_FLAGS': '0x0', 16:28:58 INFO - 'XPC_SERVICE_NAME': '0', 16:28:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:59 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 16:28:59 INFO - Cleaning up... 16:28:59 INFO - Return code: 0 16:28:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:59 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 0x10c13ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c13d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f81c5c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf18d30>, '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 0x10be3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf0dbe8>, '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.a6eQNYR9lx/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.Suxmwzu5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 16:28:59 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 16:28:59 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 16:28:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a6eQNYR9lx/Render', 16:28:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:59 INFO - 'HOME': '/Users/cltbld', 16:28:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:59 INFO - 'LOGNAME': 'cltbld', 16:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:59 INFO - 'MOZ_NO_REMOTE': '1', 16:28:59 INFO - 'NO_EM_RESTART': '1', 16:28:59 INFO - 'PAGER': '/bin/cat', 16:28:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:59 INFO - 'PWD': '/builds/slave/test', 16:28:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:59 INFO - 'SHELL': '/bin/bash', 16:28:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Suxmwzu5fP/Listeners', 16:28:59 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 16:28:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:59 INFO - 'USER': 'cltbld', 16:28:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:59 INFO - 'XPC_FLAGS': '0x0', 16:28:59 INFO - 'XPC_SERVICE_NAME': '0', 16:28:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:59 INFO - Downloading/unpacking psutil>=3.1.1 16:28:59 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 16:28:59 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 16:28:59 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 16:28:59 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 16:28:59 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 16:28:59 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 16:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:29:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:29:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:29:02 INFO - Installing collected packages: psutil 16:29:02 INFO - Running setup.py install for psutil 16:29:02 INFO - building 'psutil._psutil_osx' extension 16:29:02 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 16:29:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:29:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:29:03 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 16:29:03 INFO - building 'psutil._psutil_posix' extension 16:29:03 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 16:29:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:29:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:29:03 INFO - ^ 16:29:03 INFO - 1 warning generated. 16:29:03 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 16:29:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:29:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:29:03 INFO - Successfully installed psutil 16:29:03 INFO - Cleaning up... 16:29:03 INFO - Return code: 0 16:29:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:29:03 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')]} 16:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:03 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')]} 16:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:03 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 0x10c13ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c13d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f81c5c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf18d30>, '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 0x10be3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf0dbe8>, '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.a6eQNYR9lx/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.Suxmwzu5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 16:29:03 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 16:29:03 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 16:29:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a6eQNYR9lx/Render', 16:29:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:03 INFO - 'HOME': '/Users/cltbld', 16:29:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:03 INFO - 'LOGNAME': 'cltbld', 16:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:03 INFO - 'MOZ_NO_REMOTE': '1', 16:29:03 INFO - 'NO_EM_RESTART': '1', 16:29:03 INFO - 'PAGER': '/bin/cat', 16:29:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:03 INFO - 'PWD': '/builds/slave/test', 16:29:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:03 INFO - 'SHELL': '/bin/bash', 16:29:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Suxmwzu5fP/Listeners', 16:29:03 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 16:29:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:03 INFO - 'USER': 'cltbld', 16:29:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:03 INFO - 'XPC_FLAGS': '0x0', 16:29:03 INFO - 'XPC_SERVICE_NAME': '0', 16:29:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:29:04 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 16:29:04 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 16:29:04 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 16:29:04 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 16:29:04 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 16:29:04 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 16:29:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:29:06 INFO - Installing collected packages: mozsystemmonitor 16:29:06 INFO - Running setup.py install for mozsystemmonitor 16:29:07 INFO - Successfully installed mozsystemmonitor 16:29:07 INFO - Cleaning up... 16:29:07 INFO - Return code: 0 16:29:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:29: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')]} 16:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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')]} 16:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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', '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 0x10c13ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c13d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f81c5c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf18d30>, '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 0x10be3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf0dbe8>, '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.a6eQNYR9lx/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.Suxmwzu5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 16:29: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:29: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 jsonschema==2.5.1 16:29:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a6eQNYR9lx/Render', 16:29:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:07 INFO - 'HOME': '/Users/cltbld', 16:29:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:07 INFO - 'LOGNAME': 'cltbld', 16:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:07 INFO - 'MOZ_NO_REMOTE': '1', 16:29:07 INFO - 'NO_EM_RESTART': '1', 16:29:07 INFO - 'PAGER': '/bin/cat', 16:29:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:07 INFO - 'PWD': '/builds/slave/test', 16:29:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:07 INFO - 'SHELL': '/bin/bash', 16:29:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Suxmwzu5fP/Listeners', 16:29:07 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 16:29:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:07 INFO - 'USER': 'cltbld', 16:29:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:07 INFO - 'XPC_FLAGS': '0x0', 16:29:07 INFO - 'XPC_SERVICE_NAME': '0', 16:29:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:07 INFO - Downloading/unpacking jsonschema==2.5.1 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:29:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:10 INFO - Downloading functools32-3.2.3-2.tar.gz 16:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:29:10 INFO - warning: no files found matching '*.txt' 16:29:10 INFO - no previously-included directories found matching 'build' 16:29:10 INFO - no previously-included directories found matching 'dist' 16:29:10 INFO - no previously-included directories found matching '.git*' 16:29:10 INFO - Installing collected packages: jsonschema, functools32 16:29:10 INFO - Running setup.py install for functools32 16:29:10 INFO - warning: no files found matching '*.txt' 16:29:10 INFO - no previously-included directories found matching 'build' 16:29:10 INFO - no previously-included directories found matching 'dist' 16:29:10 INFO - no previously-included directories found matching '.git*' 16:29:10 INFO - Successfully installed jsonschema functools32 16:29:10 INFO - Cleaning up... 16:29:10 INFO - Return code: 0 16:29:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:29:10 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')]} 16:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:10 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')]} 16:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:10 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 0x10c13ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c13d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f81c5c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf18d30>, '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 0x10be3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf0dbe8>, '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.a6eQNYR9lx/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.Suxmwzu5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 16:29:10 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 16:29:10 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 16:29:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a6eQNYR9lx/Render', 16:29:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:10 INFO - 'HOME': '/Users/cltbld', 16:29:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:10 INFO - 'LOGNAME': 'cltbld', 16:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:10 INFO - 'MOZ_NO_REMOTE': '1', 16:29:10 INFO - 'NO_EM_RESTART': '1', 16:29:10 INFO - 'PAGER': '/bin/cat', 16:29:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:10 INFO - 'PWD': '/builds/slave/test', 16:29:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:10 INFO - 'SHELL': '/bin/bash', 16:29:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Suxmwzu5fP/Listeners', 16:29:10 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 16:29:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:10 INFO - 'USER': 'cltbld', 16:29:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:10 INFO - 'XPC_FLAGS': '0x0', 16:29:10 INFO - 'XPC_SERVICE_NAME': '0', 16:29:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:29:11 INFO - Cleaning up... 16:29:11 INFO - Return code: 0 16:29:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c13ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c13d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f81c5c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf18d30>, '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 0x10be3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf0dbe8>, '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.a6eQNYR9lx/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.Suxmwzu5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 16:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:29:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a6eQNYR9lx/Render', 16:29:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:11 INFO - 'HOME': '/Users/cltbld', 16:29:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:11 INFO - 'LOGNAME': 'cltbld', 16:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:11 INFO - 'MOZ_NO_REMOTE': '1', 16:29:11 INFO - 'NO_EM_RESTART': '1', 16:29:11 INFO - 'PAGER': '/bin/cat', 16:29:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:11 INFO - 'PWD': '/builds/slave/test', 16:29:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:11 INFO - 'SHELL': '/bin/bash', 16:29:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Suxmwzu5fP/Listeners', 16:29:11 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 16:29:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:11 INFO - 'USER': 'cltbld', 16:29:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:11 INFO - 'XPC_FLAGS': '0x0', 16:29:11 INFO - 'XPC_SERVICE_NAME': '0', 16:29:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:11 INFO - Downloading/unpacking blobuploader==1.2.4 16:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:14 INFO - Downloading blobuploader-1.2.4.tar.gz 16:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:29:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:29:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:15 INFO - Downloading docopt-0.6.1.tar.gz 16:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:29:15 INFO - Installing collected packages: blobuploader, requests, docopt 16:29:15 INFO - Running setup.py install for blobuploader 16:29:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:29:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:29:15 INFO - Running setup.py install for requests 16:29:16 INFO - Running setup.py install for docopt 16:29:16 INFO - Successfully installed blobuploader requests docopt 16:29:16 INFO - Cleaning up... 16:29:16 INFO - Return code: 0 16:29:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c13ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c13d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f81c5c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf18d30>, '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 0x10be3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf0dbe8>, '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.a6eQNYR9lx/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.Suxmwzu5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 16:29:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:29:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a6eQNYR9lx/Render', 16:29:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:16 INFO - 'HOME': '/Users/cltbld', 16:29:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:16 INFO - 'LOGNAME': 'cltbld', 16:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:16 INFO - 'MOZ_NO_REMOTE': '1', 16:29:16 INFO - 'NO_EM_RESTART': '1', 16:29:16 INFO - 'PAGER': '/bin/cat', 16:29:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:16 INFO - 'PWD': '/builds/slave/test', 16:29:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:16 INFO - 'SHELL': '/bin/bash', 16:29:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Suxmwzu5fP/Listeners', 16:29:16 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 16:29:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:16 INFO - 'USER': 'cltbld', 16:29:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:16 INFO - 'XPC_FLAGS': '0x0', 16:29:16 INFO - 'XPC_SERVICE_NAME': '0', 16:29:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:29:16 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-W1lNd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:16 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-1wSD6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:16 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-a0rmYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:16 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-U3r8ET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:17 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-wA5NlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:17 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-giZZTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:17 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-iV1N3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:17 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-XHKum1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:17 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-yStQU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:17 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-1wLKKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:17 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-gN66IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:17 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-UsGaa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:17 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-zOSPf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:17 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-iLRokd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:18 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-zES0MV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:18 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-WcZFpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:18 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Mljy3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:29:18 INFO - Running setup.py install for manifestparser 16:29:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:29:18 INFO - Running setup.py install for mozcrash 16:29:18 INFO - Running setup.py install for mozdebug 16:29:18 INFO - Running setup.py install for mozdevice 16:29:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:29:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:29:19 INFO - Running setup.py install for mozfile 16:29:19 INFO - Running setup.py install for mozhttpd 16:29:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:29:19 INFO - Running setup.py install for mozinfo 16:29:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:29:19 INFO - Running setup.py install for mozInstall 16:29:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:29:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:29:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:29:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:29:19 INFO - Running setup.py install for mozleak 16:29:19 INFO - Running setup.py install for mozlog 16:29:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:29:19 INFO - Running setup.py install for moznetwork 16:29:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:29:20 INFO - Running setup.py install for mozprocess 16:29:20 INFO - Running setup.py install for mozprofile 16:29:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:29:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:29:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:29:20 INFO - Running setup.py install for mozrunner 16:29:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:29:20 INFO - Running setup.py install for mozscreenshot 16:29:20 INFO - Running setup.py install for moztest 16:29:20 INFO - Running setup.py install for mozversion 16:29:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:29:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:29:20 INFO - Cleaning up... 16:29:20 INFO - Return code: 0 16:29:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:20 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')]} 16:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:20 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')]} 16:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:20 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 0x10c13ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c13d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f81c5c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf18d30>, '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 0x10be3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf0dbe8>, '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.a6eQNYR9lx/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.Suxmwzu5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 16:29:20 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 16:29:20 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 16:29:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a6eQNYR9lx/Render', 16:29:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:20 INFO - 'HOME': '/Users/cltbld', 16:29:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:20 INFO - 'LOGNAME': 'cltbld', 16:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:20 INFO - 'MOZ_NO_REMOTE': '1', 16:29:20 INFO - 'NO_EM_RESTART': '1', 16:29:20 INFO - 'PAGER': '/bin/cat', 16:29:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:20 INFO - 'PWD': '/builds/slave/test', 16:29:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:20 INFO - 'SHELL': '/bin/bash', 16:29:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Suxmwzu5fP/Listeners', 16:29:20 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 16:29:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:20 INFO - 'USER': 'cltbld', 16:29:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:20 INFO - 'XPC_FLAGS': '0x0', 16:29:20 INFO - 'XPC_SERVICE_NAME': '0', 16:29:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:29:21 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-WLu5OS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29:21 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)) 16:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:21 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-N1VfCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29:21 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)) 16:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:21 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-F4mThp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29:21 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)) 16:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:21 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-_VSy0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:21 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)) 16:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:21 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-3AzDe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29:21 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)) 16:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:21 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-DZkG3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29:21 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)) 16:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:21 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-xisELY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29:21 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)) 16:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:21 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-uNPUx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-17snhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-i6iANL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Da8oTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29:22 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)) 16:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-MM87Jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:22 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)) 16:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-AHPVlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29:22 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)) 16:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-3YYrPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29:22 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)) 16:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-nusP2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:22 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)) 16:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-sCW9E3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:22 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)) 16:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-UCesFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:29:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29:26 INFO - Downloading blessings-1.6.tar.gz 16:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:29:26 INFO - Installing collected packages: blessings 16:29:26 INFO - Running setup.py install for blessings 16:29:26 INFO - Successfully installed blessings 16:29:26 INFO - Cleaning up... 16:29:26 INFO - Return code: 0 16:29:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:29:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:29:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:29:26 INFO - Reading from file tmpfile_stdout 16:29:26 INFO - Current package versions: 16:29:26 INFO - blessings == 1.6 16:29:26 INFO - blobuploader == 1.2.4 16:29:26 INFO - docopt == 0.6.1 16:29:26 INFO - functools32 == 3.2.3-2 16:29:26 INFO - jsonschema == 2.5.1 16:29:26 INFO - manifestparser == 1.1 16:29:26 INFO - mozInstall == 1.12 16:29:26 INFO - mozcrash == 1.0 16:29:26 INFO - mozdebug == 0.1 16:29:26 INFO - mozdevice == 0.49 16:29:26 INFO - mozfile == 1.2 16:29:26 INFO - mozhttpd == 0.7 16:29:26 INFO - mozinfo == 0.9 16:29:26 INFO - mozleak == 0.1 16:29:26 INFO - mozlog == 3.4 16:29:26 INFO - moznetwork == 0.27 16:29:26 INFO - mozprocess == 0.24 16:29:26 INFO - mozprofile == 0.28 16:29:26 INFO - mozrunner == 6.13 16:29:26 INFO - mozscreenshot == 0.1 16:29:26 INFO - mozsystemmonitor == 0.3 16:29:26 INFO - moztest == 0.8 16:29:26 INFO - mozversion == 1.4 16:29:26 INFO - psutil == 3.1.1 16:29:26 INFO - requests == 1.2.3 16:29:26 INFO - wsgiref == 0.1.2 16:29:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:27 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 0x10c13ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c13d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f81c5c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf18d30>, '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 0x10be3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf0dbe8>, '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.a6eQNYR9lx/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.Suxmwzu5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 16:29:27 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 16:29:27 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 16:29:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a6eQNYR9lx/Render', 16:29:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:27 INFO - 'HOME': '/Users/cltbld', 16:29:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:27 INFO - 'LOGNAME': 'cltbld', 16:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:27 INFO - 'MOZ_NO_REMOTE': '1', 16:29:27 INFO - 'NO_EM_RESTART': '1', 16:29:27 INFO - 'PAGER': '/bin/cat', 16:29:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:27 INFO - 'PWD': '/builds/slave/test', 16:29:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:27 INFO - 'SHELL': '/bin/bash', 16:29:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Suxmwzu5fP/Listeners', 16:29:27 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 16:29:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:27 INFO - 'USER': 'cltbld', 16:29:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:27 INFO - 'XPC_FLAGS': '0x0', 16:29:27 INFO - 'XPC_SERVICE_NAME': '0', 16:29:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:29:27 INFO - Cleaning up... 16:29:27 INFO - Return code: 0 16:29:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c13ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c13d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f81c5c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf18d30>, '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 0x10be3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf0dbe8>, '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.a6eQNYR9lx/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.Suxmwzu5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 16:29:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:29:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a6eQNYR9lx/Render', 16:29:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:27 INFO - 'HOME': '/Users/cltbld', 16:29:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:27 INFO - 'LOGNAME': 'cltbld', 16:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:27 INFO - 'MOZ_NO_REMOTE': '1', 16:29:27 INFO - 'NO_EM_RESTART': '1', 16:29:27 INFO - 'PAGER': '/bin/cat', 16:29:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:27 INFO - 'PWD': '/builds/slave/test', 16:29:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:27 INFO - 'SHELL': '/bin/bash', 16:29:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Suxmwzu5fP/Listeners', 16:29:27 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 16:29:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:27 INFO - 'USER': 'cltbld', 16:29:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:27 INFO - 'XPC_FLAGS': '0x0', 16:29:27 INFO - 'XPC_SERVICE_NAME': '0', 16:29:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:29:27 INFO - Cleaning up... 16:29:27 INFO - Return code: 0 16:29:27 INFO - Running post-action listener: _resource_record_post_action 16:29:27 INFO - Running post-action listener: _start_resource_monitoring 16:29:27 INFO - Starting resource monitoring. 16:29:27 INFO - [mozharness: 2017-04-04 23:29:27.687763Z] Finished create-virtualenv step (success) 16:29:27 INFO - [mozharness: 2017-04-04 23:29:27.688719Z] Running install step. 16:29:27 INFO - Running pre-action listener: _resource_record_pre_action 16:29:27 INFO - Running main action method: install 16:29:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:29:27 INFO - Reading from file tmpfile_stdout 16:29:27 INFO - Detecting whether we're running mozinstall >=1.0... 16:29:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:29:28 INFO - Reading from file tmpfile_stdout 16:29:28 INFO - Output received: 16:29:28 INFO - Usage: mozinstall [options] installer 16:29:28 INFO - Options: 16:29:28 INFO - -h, --help show this help message and exit 16:29:28 INFO - -d DEST, --destination=DEST 16:29:28 INFO - Directory to install application into. [default: 16:29:28 INFO - "/builds/slave/test"] 16:29:28 INFO - --app=APP Application being installed. [default: firefox] 16:29:28 INFO - mkdir: /builds/slave/test/build/application 16:29:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:29:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 16:29:42 INFO - Reading from file tmpfile_stdout 16:29:42 INFO - Output received: 16:29:42 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 16:29:42 INFO - Running post-action listener: _resource_record_post_action 16:29:42 INFO - [mozharness: 2017-04-04 23:29:42.522366Z] Finished install step (success) 16:29:42 INFO - [mozharness: 2017-04-04 23:29:42.522510Z] Running run-tests step. 16:29:42 INFO - Running pre-action listener: _resource_record_pre_action 16:29:42 INFO - Running main action method: run_tests 16:29:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:29:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:29:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:29:42 INFO - 2017-04-04 16:29:42.536 screenresolution[1621:7223] starting screenresolution argv=screenresolution get 16:29:42 INFO - 2017-04-04 16:29:42.539 screenresolution[1621:7223] Display 0: 1600x1200x32@60 16:29:42 INFO - 2017-04-04 16:29:42.545 screenresolution[1622:7225] starting screenresolution argv=screenresolution list 16:29:42 INFO - Available Modes on Display 0 16:29:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:29:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:29:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:29:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:29:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:29:42 INFO - Intel Iris: 16:29:42 INFO - Chipset Model: Intel Iris 16:29:42 INFO - Type: GPU 16:29:42 INFO - Bus: Built-In 16:29:42 INFO - VRAM (Dynamic, Max): 1536 MB 16:29:42 INFO - Vendor: Intel (0x8086) 16:29:42 INFO - Device ID: 0x0a2e 16:29:42 INFO - Revision ID: 0x0009 16:29:42 INFO - Displays: 16:29:42 INFO - Display: 16:29:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:29:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:29:42 INFO - Display Serial Number: 1600x1200 60 16:29:42 INFO - Main Display: Yes 16:29:42 INFO - Mirror: Off 16:29:42 INFO - Online: Yes 16:29:42 INFO - Rotation: Supported 16:29:42 INFO - Return code: 0 16:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:29:42 INFO - Python 2.7.3 16:29:42 INFO - Return code: 0 16:29:42 INFO - grabbing minidump binary from tooltool 16:29: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')]} 16:29:42 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 0x10bf18d30>, '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 0x10be3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf0dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:29:42 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 16:29:42 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 16:29:42 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 16:29:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:29:42 INFO - Return code: 0 16:29:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:29:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:29:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:29:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:29:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 16:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0353 --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 16:29:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a6eQNYR9lx/Render', 16:29:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:42 INFO - 'HOME': '/Users/cltbld', 16:29:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:42 INFO - 'LOGNAME': 'cltbld', 16:29:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:29:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:42 INFO - 'MOZ_NO_REMOTE': '1', 16:29:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:29:42 INFO - 'NO_EM_RESTART': '1', 16:29:42 INFO - 'PAGER': '/bin/cat', 16:29:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:42 INFO - 'PWD': '/builds/slave/test', 16:29:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:29:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:42 INFO - 'SHELL': '/bin/bash', 16:29:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Suxmwzu5fP/Listeners', 16:29:42 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 16:29:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:42 INFO - 'USER': 'cltbld', 16:29:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:42 INFO - 'XPC_FLAGS': '0x0', 16:29:42 INFO - 'XPC_SERVICE_NAME': '0', 16:29:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 16:29:43 INFO - mozversion application_buildid: 20170404153430 16:29:43 INFO - mozversion application_changeset: 41323426061e6cd60125b5f0728442faca1cbe60 16:29:43 INFO - mozversion application_display_name: Firefox 16:29:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:29:43 INFO - mozversion application_name: Firefox 16:29:43 INFO - mozversion application_remotingname: firefox 16:29:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:29:43 INFO - mozversion application_vendor: Mozilla 16:29:43 INFO - mozversion application_version: 53.0 16:29:43 INFO - mozversion platform_buildid: 20170404153430 16:29:43 INFO - mozversion platform_changeset: 41323426061e6cd60125b5f0728442faca1cbe60 16:29:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:29:43 INFO - mozversion platform_version: 53.0 16:29:43 INFO - using testdate: 1491348583 16:29:43 INFO - actual date: 1491348583 16:29:43 INFO - starting webserver on 'localhost:49241' 16:29:43 INFO - SUITE-START | Running 2 tests 16:29:43 INFO - TEST-START | dromaeo_css 16:29:43 INFO - operating with platform_type : mac_ 16:29:43 INFO - Initialising browser for dromaeo_css test... 16:29:43 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpJf38so/profile http://localhost:49241/getInfo.html) 16:29:45 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 16:29:45 INFO - PROCESS | 1632 | colorDepth:24 16:29:45 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 16:29:45 INFO - PROCESS | 1632 | __metrics 16:29:45 INFO - PROCESS | 1632 | 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" 16:29:45 INFO - PROCESS | 1632 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:29:46 INFO - TEST-INFO | 1632: exit 0 16:29:46 INFO - Browser initialized. 16:29:46 INFO - Running cycle 1/1 for dromaeo_css test... 16:29:46 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpJf38so/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:29:58 INFO - PROCESS | 1635 | RSS: Main: 164073472 16:29:58 INFO - PROCESS | 1635 | 16:33:01 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 16:33:02 INFO - PROCESS | 1635 | RSS: Main: 280948736 16:33:02 INFO - PROCESS | 1635 | 16:36:05 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 16:36:06 INFO - PROCESS | 1635 | RSS: Main: 311545856 16:36:06 INFO - PROCESS | 1635 | 16:39:08 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 16:39:08 INFO - PROCESS | 1635 | RSS: Main: 303828992 16:39:08 INFO - PROCESS | 1635 | 16:42:11 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 16:42:11 INFO - PROCESS | 1635 | RSS: Main: 271933440 16:42:11 INFO - PROCESS | 1635 | 16:45:14 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 16:45:15 INFO - PROCESS | 1635 | RSS: Main: 270381056 16:45:15 INFO - PROCESS | 1635 | 16:48:18 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 16:48:18 INFO - PROCESS | 1635 | RSS: Main: 344014848 16:48:18 INFO - PROCESS | 1635 | 16:48:18 INFO - PROCESS | 1635 | __start_tp_report 16:48:18 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 16:48:18 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 16:48:18 INFO - PROCESS | 1635 | |i|pagename|runs| 16:48:18 INFO - PROCESS | 1635 | |0;dojo.html;3059.2351912022;3511.3679537683224;3523.365555395247;3526.8236588170585;3579.67782899539;5809.535237181026;5810.767569297228;5858.41415858415;5864.208331875196;5893.116032595108;5830.125481177825;5859.414058594139;5875.676837773932;5888.882222355551;5903.4686878180955;5290.867728306804;5350.30446042014;5351.946480535184;5381.246625472418;5419.268398766175;5286.577073834103;5289.021531016755;5295.7881684732565;5295.973520132413;5323.707196104213;5376.865578360533;5399.37907140678;5405.864853378677;5409.729513524328;5436.293281873351;5381.327334083239;5385.569154467633;5399.676019438807;5403.297571315743;5452.482014208644;5151.5106064923775;5247.317848679685;5263.078961181778;5307.310049693554;5310.840674779763;5802.941970580282;5827.213326200994;5850.0932355484965;5877.67672777997;5932.377100404482;6332.050192471166;6342.460890824285;6367.936320636781;6378.394052564999;6405.519586031066;5989.13157592151;6158.630482171084;6268.091126786636;6345.873082538324;6350.174477317965;5835.183074369592;5967.671778052206;6002.909956350658;6006.669633170174;6094.756209751649;6337.017762246859;6384.329645387167;6390.0734393512685;6406.775762848278;6408.903866442007;6273.780417685359;6323.9683801580695;6343.207099112611;6345.587536810092;6353.809385718436;4372.672049596229;6248.125262463259;6289.811305660837;6299;6301.212348456443;6355.237371515355;6372.107904893319;6376.617402955838;6385.6487893165395;6399.456046236029;6301.558890877594;6302.369763023661;6307.5584709070845;6339.873202535923;6362.141110949962;5000.2749601307605;5027.698338099725;5027.949720502821;5035.320231768665;5042.39491261051;4548.522405147478;4576.97711511447;4581;4589.380433641482;4621.792019359137;5889.440503152194;5928.199693041471;5942.257217847769;5948.196993405835;5960.910586341209;6125.937554509019;6218.19163508741;6342.651154186472;6350.4602108820345;6357.982722764335;5810.88378232433;5834.27071616048;5873.559483038789;5880.176775251468;5904.911426328608;5457.263269458652;5515.365732940683;5531;5542.695151766611;5570.220169176318;6217.4715149212825;6390.648514331757;6391.584547004616;6398.616083035033;6411.775587854403;6221.626702397871;6239.844003899939;6254.468370188403;6322.3045464997895;6323.399277068671;6396.42432181106;6408.134901788386;6413.422791948747;6419.775307864203;6426.357364263723;6326.873462530815;6336.493080553637;6351.618902865843;6354.428101470705;6370.522210834299;6230.065490176328;6231.096491008869;6249.125122482947;6256.155419018374;6290.937090629035;4582.175208462509;6005.759769609342;6263.843403914939;6296.905546416716;6300.054991751274;6185.381461853779;6240.157578726814;6253.812385628438;6255.093011513396;6256.624602523863;4445.37764712947;6025.578209525466;6059.787907423219;6087.178230938944;6181.381861813783;6142.989934931762;6232.8130156095385;6257.874842503215;6272.372762723691;6280.434760871543;5997.4002599741425;6058.363871793398;6107.358727333566;6126.754929802758;6132.509399247961 16:48:18 INFO - PROCESS | 1635 | |1;ext.html;521.1687358662932;533.7197971065191;551.3218740948633;552.1827695011381;559.5758793869602;32758.836205818967;42719.572804271986;44174.779126104324;44365.33451998223;46705;46124.07751844961;46309;46930.53069469304;47049;47078.52921470784;8930.062343453941;9452;9676.371035882645;9680.031996800333;9690.46702431366;8973.371863969525;9178.86231706525;9182.540872956359;9183.403078799856;11695.239809412362;11762.00022998042;11908.880911190907;11910.7617847643;11926.045916326717;11957.820632690517;11710.824337634942;11786.410679465993;11793.705157371049;11801.409929503534;11817;11682.532698692043;11741.354225517593;11749.530018799238;11779.411029448578;11784.469698863571;42197;42482.57517424848;42527.787361063;42550.7234782957;42612.57387426117;4055.6755459563165;4069.308217603015;4106.507219133723;4116.9794151029355;4127.731697439657;30515.542266866014;30649.540256896165;32029.039128825938;32504.02487925366;33101.00696979094;3182.379436009979;3207.631122420905;3320.3027364253535;3332.96667033329;3436.621971583124;504623;506115;506910;509770;510054.4497277527;68437.65781171063;68673.999999999;68782;69262;69282.65358673275;72037.63981180165;72078.63960680163;72146.9177962331;72166.63916680383;72176.91734623985;17503.73744393835;18140.818591814175;18149.7277540837;18178.818211817714;18180;13773.311334433238;13865.653358666113;13885.791713124312;13887.58337249884;13900.860991390158;16705.6658866822;17113.914430428016;17161.399351022654;17334.739978900325;18273.105889368773;6239.625622462667;6244.875102498016;6254.624722516573;6266.717997690115;7339.74310899116;906.6101576322245;909.6179604566098;915.555955361649;933.6032186320787;948.2840455456087;31475.213119672193;32664.510032349535;34607.82696086554;34703.9588812336;35199.296014080086;905.307439808547;1012.5747186181821;1114.2590177531852;1117.9826358014168;1222.786012447836;16034.358625654842;16124.838751612333;16377.836221637632;16396.344146234256;17031.953656452028;535290;673181;677978;678820;679114;47434.762826186336;51871;52959;58775.41224587785;59298.70350648219;1526.7862499250114;1551.8525740054677;1559.2281820498927;1575.4249698859833;1575.8345373735592;28851.56722649204;30513.542296865122;32769.50845737364;32927.341453170324;33627.15932101717;46763.766181170235;47015;53133.46866531285;57625.423745763685;57638.7118064407;623192;652646;667350;882765;895054.5247273722;44036.559634403246;44291.67124986256;44422;44505;44569.33146002878;49344.50655493399;49965;50213.74893125511;50896.23655645242;51040.74479627578;33200.011998920214;33893.152671183416;33995.66004339925;34003.829980850925;34948.30103397867;33502.49746253759;33678.66321336755;33730.66269337275;34244.48633270553;34470.138246543036;38954.2209155821;39892.60107398889;40029;40337;40348.79825600853;32882.17794555155;33312.83405080908;33621.83189084039;33879.66120338765;34624.615015399104;19772.30796922101;26252.243514431473;26282.652377763046;26340.736592633828;27043.86478067597 16:48:18 INFO - PROCESS | 1635 | |2;jquery.html;337.7669408108405;407.5781566079108;411.12430522986074;417.63039709856787;437.6892406391462;21304.680429793567;21433.57132857344;21559.784402155972;22057.669134962947;22259.332220033404;22184.223552175677;22608;23286.767132328714;23425;23667.763322366773;5786.999999999989;6017.518598512109;6075.392460753911;6091.269047714259;6095.908561371561;5768.653880767147;5895.086261629454;5936.465718085371;5999.340072592011;6013.639181649115;5955.910661340062;5962.73167707452;5969.791057312995;5970.970145149268;5971.940280597182;5724.055530837407;5869.941300586982;5934.5845790794665;5948.405159484017;5949.7025148742605;5026.47222041684;5255.395629502618;5261.368635763694;5268.604854635918;5271.789128434858;23342.76657233423;23778.762212377827;23810.64284035741;27115.864420677968;27130.914763409637;2722.7005029446746;2735.904243351493;2754.862256887148;2759.503289407906;2767.5848622706553;16441.26014329358;16570.337186512526;16597.66804663912;16692.41576544815;17047.659046819117;1835.5104111742323;1897.2790339670976;1912.6557219700449;1920.395075551197;1922.8942408167545;128633;131155;136185.319073405;137188;137734;11607.76784464323;11811.350375729417;11837.171398002229;11996.280223186637;12002.399880005965;15436.382544698086;15474.845251547566;15487;15490.225488725519;15519.767203491956;7791.104023037423;9037.548122593844;9082.31882608807;9267.907320926839;9270.72187834366;9148.359614826899;9152.757574394316;9184.448933064037;9321.254299656146;9350.298727595458;7329.743458979016;7561.09266887966;7569.129550101698;7606.163322034572;7623.695052197961;1757.5606098475382;1959.480737604536;1984;1996.5008747813047;1998.4803950972853;798.872180451125;1039.0544604410102;1054.1250761867632;1074.693712291993;1140.520981187903;20448.795512044988;24008.15971440991;24169.154079607128;24584.139555115486;24601.753982460305;1086.3699054548342;1106.5573770491867;1106.773111512138;1118.2100658856207;1133.393634405589;11698.532058717727;11968.880311196777;12485.50057997688;12630.747385052247;12642.2414655121;799353;830553;835766;836244.8187759144;839844;151306;157306;158449.41550584577;159762;163116.1844190795;1056.6882769582992;1080.735219871121;1110.3781882146025;1111.7331840358256;1117.5362224676994;16885;19546.628064886627;20749.89625051865;20909.790902090783;20937.581248375252;58463;58779;59501.702491489;60821;61263;86916;87922.56038719765;88626;90165;91155.54422227846;8474.788130296793;8567.4002819802;8646.870296945424;8810.647574096964;8872.201501864864;11262.099032077578;12336.198147120409;13212.207267563977;13242.53651122206;13584.45662173502;11299.830502542633;11581.7104572383;11597.072234221074;11704.590339338083;11769.470373833026;10687.091597214323;10691.465426728477;10813.56745730162;10823.621173258898;11033.668989930315;11295.548178072784;11621.593244236412;11668.241564298633;11956.880431195925;11986.981106606036;8536.74389768308;8552.615132318937;8609.569521523774;8754.562271886507;8876.911230887608;11389.829152562552;11406.771864562828;11474.311541307548;11734.178607497735;11816.645500634995 16:48:18 INFO - PROCESS | 1635 | |3;mootools.html;1118.2228351295848;1143.5540139345658;1143.6511863881524;1149.0807354116705;1215.981760273596;8238.546879921601;8624.051354351024;8626.396152269344;8635.568221588926;8645.78385540361;7541.434392420563;7757.49576277543;7763.534187948727;8041.758747237577;8391.70629027984;2333.6966194394704;2432.1852179519883;2436.5735996200683;2442.1818690738623;2449.5223431430877;2409.084547871815;2443.4135807406183;2453.2272334214667;2461.163204510466;2465.4329504214043;1777.8755487115843;2096.4758810297426;2211.447138215446;2224.2993457060975;2225.521512874732;2203.460152262698;2331.347222777625;2407.6749638798715;2414.3239892830034;2421.2131057406414;2404.8797560121925;2415.577273977047;2416.2147302126705;2431.416460049593;2435.756424357568;8383.664653413916;8415;8473.661053557851;8474.406791524596;8482.448640838387;5220.295260139908;5371.301730774974;5372.811951581715;5377;5382.703951282678;3548.574171099459;3557.6086630470627;3608.657177568127;3638.2177831766035;3649.4160934250394;1248.650377894182;1280.327827890365;1284.800855867342;1299.5776372678918;1324.6622111361637;9336.626534938594;10667.519961601747;10812;10910.181736369805;10919.836202456969;4710.858674239778;4775.2598347256235;4822.469528351879;4863.975680121577;4867.537583929521;9686.854697179548;9688.806223875625;9703.320767546204;9716.854247186298;9718.805623887483;5329.680219186861;5392.595555333366;5413.702246376409;5422.945770542244;5440.347158341025;4700.130475861976;4807.278908163804;4861.611071114302;4949.752512374367;4977.303177555145;3784.6215378462484;3849.4418309344987;3872.7095467839463;3901.941470877939;3904.7266691331333;1194.474431250247;1195.54569263681;1199.8320235167084;1208.3233389301843;1208.8549374074992;797.8085259537669;917.775145089444;920.7974245665943;929.3215952354819;938.6996161228342;5366.168243922199;5728.341240757366;5771.711414429262;5920.319163296276;5949.3455719871645;942.853857652065;1003.2124782046059;1028.943408112561;1031.2159963263596;1075.7525769073156;3732.309522738302;3879.359905615598;3886.145048089416;3901.3367727486398;4092.836286548564;9431.952840235756;9613.423194608346;9708.805823883624;9717.514124293757;9724.805503889882;9434.528273586293;9601.087896649808;9621.9037809621;9824.607015719434;9827.164691001202;7698.114716807639;7872.17342179063;7880.921190788019;7897.881531777028;7916.168802275678;5362.249285100167;5639.351474580476;5647.745851436777;5893.019937373637;5982.102684597346;9354.298427618092;9392.060793920553;9421.38760980534;9436.905630943877;9441.008694087022;8774.429662071945;9273.072692730673;9414.95292523533;9574.377665451724;9580.658707781056;6799.150106236721;7187.532810367309;7279.235680253497;7371.483996120434;7404.222556631476;7789.766307010798;7975.481593696391;8080.71717489885;8083.757487275391;8174.264316211569;7072.151341839012;7124.465665075244;7148.857022859618;7173.426125910019;7198;6965.860682786215;7001.4748893834185;7025.192102908231;7077.009218709281;7152.85694286101;6461.321561236191;6493.837654058686;6581.44057755077;6583.242927063449;6597.109390232257;4343.391925130548;5010.323606313101;5030.37120359955;5178.456262092426;5303.310569625924;4675.649326300609;5043.445221025758;5115.897682046412;5137.1010073237785;5282.366116066097 16:48:18 INFO - PROCESS | 1635 | |4;prototype.html;346.18818869750436;375.6056141051895;380.9257194847005;390.8026446644444;392.0766594669555;4754.930140718341;5088.0587091388115;5271.841844744654;5283.996040752259;5355.732213389325;4052.4731784868;4678.602318802906;4735.73953432561;5008.595873980492;5147.279380886669;3763.623637636228;3816.637419445148;3997.960020399788;4118.546959834423;4196.9370459443135;4131.690123240754;4133.7106402551835;4177.707560470768;4193.832246710143;4219.017061980864;3584.677379035886;3660.4143337066075;3828.7511311764783;4121.835126594948;4168.8332466701295;4087.1621317629965;4108.5275193352545;4136.937945930814;4144.564820693844;4150.771707556083;3150.149459645883;3669.7064234861145;3695.7597756145765;3709.9072523186865;3710.350688629479;4835.734034628094;4879.926801097987;5185.325907632021;5239.318888544465;5240.3973543042275;4219.831206751726;4621.8445388652835;4649.628029757645;4655.348251244828;4668.626509879202;4949.267756285308;4960.528749768766;5560.304961879765;5587.469190426903;5622.088489913408;3457.75246090041;3895.3962135868987;3903.8243279052513;3918.1380096378753;3927.9803600981813;4936.703797772145;5495.642783219078;5771.249737534094;5803.912941305884;5827.854303642358;3440.8301177599737;3876.903077423087;3899;3924.0189952511873;3952.3281042222893;3968.523777146703;3984.1353886729826;4011.6389524942897;4017.9397309040387;4047.817848196838;3768.510093687803;3919.6668283195677;4532.229520981441;4556.749378784132;4599.356090147382;4875.366202393666;4949.604031677529;5304.92042619361;5576.776928922879;5648.8870222595315;1246.6820960655157;1282.8588855225917;1298.3313593499356;1302.257713103541;1305.2494815481136;839.0450250915353;846.6147902704255;864.6022829498501;883.726044926075;884.5179377239419;4268.40242366069;4428.601425871622;4750.978539614;4796.424429068465;4982.626303027288;4559.3844830948065;5121.641485096007;5411.675299482044;5469.453054694499;5546.251256080377;4203.432536607519;4504.25679762842;4515.164694531457;4611.618961986127;4687.250039993584;2591.9352016199746;2604.0234911908033;2655.8048878004975;2826.3781967967016;2885.5383138697707;5175.948240517622;5323.0152421802095;5670.489655930986;5692.943070569241;5715.5427565794635;4688.953110468851;4790.449098353664;5202.3497062867145;5616.354119276254;5643.548516118701;4721.6458765592715;5071.847844564669;5096.592272618182;5684.573656975744;5713.6857472838565;4812.494688057844;4845.612351011981;5157.581665042144;5174.663646862942;5460.525658072378;4805.423349198119;5143.71709555978;5330.920036199538;5387.084195686664;5484.753186106715;4689.249720044776;5121.257417674491;5272.420033796203;5455.9454405455435;5700.230468886647;3271.411145993649;3674.0998455378603;3750.780996176199;3768.924621507609;3771.6039815818945;4699.3890794197905;5142.742862856917;5360.115580929259;5389.62272640927;5465.918011229755;4611.6310695144975;4941.579965702956;5236.581073514186;5238.188080847474;5275.815346462856;4539.024109816405;4721.0493441599;4730.935539503585;4789.970156416387;5206.984637995554;4612.465041949741;4727.409073865767;4781.915664396514;4789.976050119727;5180.61145414103;5338.759755811076;5451.7274136292235;5477.890442191054;5481.588880834033;5490.890182196414;4962.528559786814;5410.323709536308;5427.398917319321;5438.211459338453;5476.452354764491 16:48:18 INFO - PROCESS | 1635 | |5;yui.html;744.7728442824937;759.0625577411898;799.5282783157936;883.7878909061826;897.6678628907305;15318.693626127484;15970.600734981617;15978.76031859523;15991.760123598126;16009.919950400246;14542.854571454282;14617.561473155822;14652.633684157901;14677.706445871076;14740.41038358467;734.7244783206297;764.2815753192009;768.9307962283393;920.9915142918494;939.5537119868043;744.7691215723116;750.9436792240576;752.7553545097837;895.2837729816121;939.9154076133146;990.227622454483;990.9058639429243;1000.7448100734302;1006.733215697837;1008.334499230508;996.9401835889797;999.8200323941687;999.9200063994863;1004.5730564510054;1007.788364443464;744.3375395897656;745.3105877063695;746.5520687587405;748.6556184155295;749.1310080306818;14608.926955365261;14667.119972801665;14667.559973200821;15922;16191.947523411058;14477.131372117707;14686.779698304534;14943.701125977419;14948.476803311833;15232.314545845464;10437.895621043845;11713.39812012108;11882.346470944094;11900.285982840971;12211.572594959134;3796.8481260749536;3930.78380689062;3946.5461471930807;3948.861789837342;4093.5906409358827;106997;110199;111019.44490277578;111421;112711.99999999919;9092.408993415407;9667.661631842993;11315.547378104948;11369.374684392273;11861.525538978516;24287.878560607085;24297.514049718906;24331.0267589298;24335.513289734106;24349.026038958244;7138.179109402381;7618.657160427794;7939.3251573615735;8041;8182.509049457051;4418.624416924533;4532.388127602798;4539.682222244412;4582.060677561092;4737.360456338419;3696.4085746281003;3798.6771124454176;3799.2211596622624;3808.1812410331913;3812.4853144825647;670.5909395268882;673.3434900971612;708.6633848921824;718.8202949262684;719.1801346465035;582.994170058294;697.2992142896356;742.4876834983952;746.4101463882005;750.6622020090981;10122.443265620313;10511.211659125596;10817.675469735921;11016.779664406668;11054.392008439612;589.5607772209731;679.6975345970995;706.593708617547;713.7216485570632;738.3281214095255;4132.235536425711;5122.436531981479;5138.12651849179;5149.253358263106;5152.458991805881;75859.62070189614;99176;109658;111197.44401278104;111367;90169.54915225382;94460.05539944513;95233.52383238178;96242;96279.51860240653;81495.370092599;83754;83767.16232837837;84917.57541212255;84959;9800.59249670138;9938;10018.3488073275;10032.64885728996;10049.849252261076;53793;54234;54321;54569.45430545803;55796.97827195572;66043;72364;73531;73568;73796;12103.697407564881;12349.691257718629;12375.814362784746;12430.937845310715;12658.050646201757;12979.870201297867;13351.3991870368;13415.798763018367;13580.864191358356;13985.370658320197;12092.274463532216;12408.875911241134;12631.178973366701;12694.936525317315;12852.55016074433;11908.40457977115;12391.876081239072;12565.811512827133;12628;12845.229286242855;11787.115966302734;11972.76054478923;12214.26714397139;12290.631281061582;12636.43136058898;7918;9063.592138353659;9321.394109382869;9491.905080949102;9622.711318660451;10169.440680762333;10248.692539223835;10263.23025773055;10263.640772572924;10306.690799276033 16:48:18 INFO - PROCESS | 1635 | __end_tp_report 16:48:18 INFO - PROCESS | 1635 | __start_cc_report 16:48:18 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,1173 16:48:18 INFO - PROCESS | 1635 | __end_cc_report 16:48:18 INFO - PROCESS | 1635 | __startTimestamp1491349698756__endTimestamp 16:48:18 INFO - PROCESS | 1635 | 16:48:18 INFO - PROCESS | 1635 | ------- Summary: start ------- 16:48:18 INFO - PROCESS | 1635 | Number of tests: 6 16:48:18 INFO - PROCESS | 1635 | 16:48:18 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5839.05 Median:6059.79 stddev:658.26 (10.9%) stddev-sans-first:623.11 16:48:18 INFO - PROCESS | 1635 | Values: 3059.2 3511.4 3523.4 3526.8 3579.7 5809.5 5810.8 5858.4 5864.2 5893.1 5830.1 5859.4 5875.7 5888.9 5903.5 5290.9 5350.3 5351.9 5381.2 5419.3 5286.6 5289.0 5295.8 5296.0 5323.7 5376.9 5399.4 5405.9 5409.7 5436.3 5381.3 5385.6 5399.7 5403.3 5452.5 5151.5 5247.3 5263.1 5307.3 5310.8 5802.9 5827.2 5850.1 5877.7 5932.4 6332.1 6342.5 6367.9 6378.4 6405.5 5989.1 6158.6 6268.1 6345.9 6350.2 5835.2 5967.7 6002.9 6006.7 6094.8 6337.0 6384.3 6390.1 6406.8 6408.9 6273.8 6324.0 6343.2 6345.6 6353.8 4372.7 6248.1 6289.8 6299.0 6301.2 6355.2 6372.1 6376.6 6385.6 6399.5 6301.6 6302.4 6307.6 6339.9 6362.1 5000.3 5027.7 5027.9 5035.3 5042.4 4548.5 4577.0 4581.0 4589.4 4621.8 5889.4 5928.2 5942.3 5948.2 5960.9 6125.9 6218.2 6342.7 6350.5 6358.0 5810.9 5834.3 5873.6 5880.2 5904.9 5457.3 5515.4 5531.0 5542.7 5570.2 6217.5 6390.6 6391.6 6398.6 6411.8 6221.6 6239.8 6254.5 6322.3 6323.4 6396.4 6408.1 6413.4 6419.8 6426.4 6326.9 6336.5 6351.6 6354.4 6370.5 6230.1 6231.1 6249.1 6256.2 6290.9 4582.2 6005.8 6263.8 6296.9 6300.1 6185.4 6240.2 6253.8 6255.1 6256.6 4445.4 6025.6 6059.8 6087.2 6181.4 6143.0 6232.8 6257.9 6272.4 6280.4 5997.4 6058.4 6107.4 6126.8 6132.5 16:48:18 INFO - PROCESS | 1635 | 16:48:18 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:77112.47 Median:22202.24 stddev:173069.12 (779.5%) stddev-sans-first:173459.08 16:48:18 INFO - PROCESS | 1635 | Values: 521.2 533.7 551.3 552.2 559.6 32758.8 42719.6 44174.8 44365.3 46705.0 46124.1 46309.0 46930.5 47049.0 47078.5 8930.1 9452.0 9676.4 9680.0 9690.5 8973.4 9178.9 9182.5 9183.4 11695.2 11762.0 11908.9 11910.8 11926.0 11957.8 11710.8 11786.4 11793.7 11801.4 11817.0 11682.5 11741.4 11749.5 11779.4 11784.5 42197.0 42482.6 42527.8 42550.7 42612.6 4055.7 4069.3 4106.5 4117.0 4127.7 30515.5 30649.5 32029.0 32504.0 33101.0 3182.4 3207.6 3320.3 3333.0 3436.6 504623.0 506115.0 506910.0 509770.0 510054.4 68437.7 68674.0 68782.0 69262.0 69282.7 72037.6 72078.6 72146.9 72166.6 72176.9 17503.7 18140.8 18149.7 18178.8 18180.0 13773.3 13865.7 13885.8 13887.6 13900.9 16705.7 17113.9 17161.4 17334.7 18273.1 6239.6 6244.9 6254.6 6266.7 7339.7 906.6 909.6 915.6 933.6 948.3 31475.2 32664.5 34607.8 34704.0 35199.3 905.3 1012.6 1114.3 1118.0 1222.8 16034.4 16124.8 16377.8 16396.3 17032.0 535290.0 673181.0 677978.0 678820.0 679114.0 47434.8 51871.0 52959.0 58775.4 59298.7 1526.8 1551.9 1559.2 1575.4 1575.8 28851.6 30513.5 32769.5 32927.3 33627.2 46763.8 47015.0 53133.5 57625.4 57638.7 623192.0 652646.0 667350.0 882765.0 895054.5 44036.6 44291.7 44422.0 44505.0 44569.3 49344.5 49965.0 50213.7 50896.2 51040.7 33200.0 33893.2 33995.7 34003.8 34948.3 33502.5 33678.7 33730.7 34244.5 34470.1 38954.2 39892.6 40029.0 40337.0 40348.8 32882.2 33312.8 33621.8 33879.7 34624.6 19772.3 26252.2 26282.7 26340.7 27043.9 16:48:18 INFO - PROCESS | 1635 | 16:48:18 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:43869.65 Median:22433.67 stddev:137436.81 (612.6%) stddev-sans-first:137783.48 16:48:18 INFO - PROCESS | 1635 | Values: 337.8 407.6 411.1 417.6 437.7 21304.7 21433.6 21559.8 22057.7 22259.3 22184.2 22608.0 23286.8 23425.0 23667.8 5787.0 6017.5 6075.4 6091.3 6095.9 5768.7 5895.1 5936.5 5999.3 6013.6 5955.9 5962.7 5969.8 5971.0 5971.9 5724.1 5869.9 5934.6 5948.4 5949.7 5026.5 5255.4 5261.4 5268.6 5271.8 23342.8 23778.8 23810.6 27115.9 27130.9 2722.7 2735.9 2754.9 2759.5 2767.6 16441.3 16570.3 16597.7 16692.4 17047.7 1835.5 1897.3 1912.7 1920.4 1922.9 128633.0 131155.0 136185.3 137188.0 137734.0 11607.8 11811.4 11837.2 11996.3 12002.4 15436.4 15474.8 15487.0 15490.2 15519.8 7791.1 9037.5 9082.3 9267.9 9270.7 9148.4 9152.8 9184.4 9321.3 9350.3 7329.7 7561.1 7569.1 7606.2 7623.7 1757.6 1959.5 1984.0 1996.5 1998.5 798.9 1039.1 1054.1 1074.7 1140.5 20448.8 24008.2 24169.2 24584.1 24601.8 1086.4 1106.6 1106.8 1118.2 1133.4 11698.5 11968.9 12485.5 12630.7 12642.2 799353.0 830553.0 835766.0 836244.8 839844.0 151306.0 157306.0 158449.4 159762.0 163116.2 1056.7 1080.7 1110.4 1111.7 1117.5 16885.0 19546.6 20749.9 20909.8 20937.6 58463.0 58779.0 59501.7 60821.0 61263.0 86916.0 87922.6 88626.0 90165.0 91155.5 8474.8 8567.4 8646.9 8810.6 8872.2 11262.1 12336.2 13212.2 13242.5 13584.5 11299.8 11581.7 11597.1 11704.6 11769.5 10687.1 10691.5 10813.6 10823.6 11033.7 11295.5 11621.6 11668.2 11956.9 11987.0 8536.7 8552.6 8609.6 8754.6 8876.9 11389.8 11406.8 11474.3 11734.2 11816.6 16:48:18 INFO - PROCESS | 1635 | 16:48:18 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5487.15 Median:5387.65 stddev:2940.18 (54.6%) stddev-sans-first:2930.08 16:48:18 INFO - PROCESS | 1635 | Values: 1118.2 1143.6 1143.7 1149.1 1216.0 8238.5 8624.1 8626.4 8635.6 8645.8 7541.4 7757.5 7763.5 8041.8 8391.7 2333.7 2432.2 2436.6 2442.2 2449.5 2409.1 2443.4 2453.2 2461.2 2465.4 1777.9 2096.5 2211.4 2224.3 2225.5 2203.5 2331.3 2407.7 2414.3 2421.2 2404.9 2415.6 2416.2 2431.4 2435.8 8383.7 8415.0 8473.7 8474.4 8482.4 5220.3 5371.3 5372.8 5377.0 5382.7 3548.6 3557.6 3608.7 3638.2 3649.4 1248.7 1280.3 1284.8 1299.6 1324.7 9336.6 10667.5 10812.0 10910.2 10919.8 4710.9 4775.3 4822.5 4864.0 4867.5 9686.9 9688.8 9703.3 9716.9 9718.8 5329.7 5392.6 5413.7 5422.9 5440.3 4700.1 4807.3 4861.6 4949.8 4977.3 3784.6 3849.4 3872.7 3901.9 3904.7 1194.5 1195.5 1199.8 1208.3 1208.9 797.8 917.8 920.8 929.3 938.7 5366.2 5728.3 5771.7 5920.3 5949.3 942.9 1003.2 1028.9 1031.2 1075.8 3732.3 3879.4 3886.1 3901.3 4092.8 9432.0 9613.4 9708.8 9717.5 9724.8 9434.5 9601.1 9621.9 9824.6 9827.2 7698.1 7872.2 7880.9 7897.9 7916.2 5362.2 5639.4 5647.7 5893.0 5982.1 9354.3 9392.1 9421.4 9436.9 9441.0 8774.4 9273.1 9415.0 9574.4 9580.7 6799.2 7187.5 7279.2 7371.5 7404.2 7789.8 7975.5 8080.7 8083.8 8174.3 7072.2 7124.5 7148.9 7173.4 7198.0 6965.9 7001.5 7025.2 7077.0 7152.9 6461.3 6493.8 6581.4 6583.2 6597.1 4343.4 5010.3 5030.4 5178.5 5303.3 4675.6 5043.4 5115.9 5137.1 5282.4 16:48:18 INFO - PROCESS | 1635 | 16:48:18 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4355.94 Median:4743.36 stddev:1279.77 (27.0%) stddev-sans-first:1247.47 16:48:18 INFO - PROCESS | 1635 | Values: 346.2 375.6 380.9 390.8 392.1 4754.9 5088.1 5271.8 5284.0 5355.7 4052.5 4678.6 4735.7 5008.6 5147.3 3763.6 3816.6 3998.0 4118.5 4196.9 4131.7 4133.7 4177.7 4193.8 4219.0 3584.7 3660.4 3828.8 4121.8 4168.8 4087.2 4108.5 4136.9 4144.6 4150.8 3150.1 3669.7 3695.8 3709.9 3710.4 4835.7 4879.9 5185.3 5239.3 5240.4 4219.8 4621.8 4649.6 4655.3 4668.6 4949.3 4960.5 5560.3 5587.5 5622.1 3457.8 3895.4 3903.8 3918.1 3928.0 4936.7 5495.6 5771.2 5803.9 5827.9 3440.8 3876.9 3899.0 3924.0 3952.3 3968.5 3984.1 4011.6 4017.9 4047.8 3768.5 3919.7 4532.2 4556.7 4599.4 4875.4 4949.6 5304.9 5576.8 5648.9 1246.7 1282.9 1298.3 1302.3 1305.2 839.0 846.6 864.6 883.7 884.5 4268.4 4428.6 4751.0 4796.4 4982.6 4559.4 5121.6 5411.7 5469.5 5546.3 4203.4 4504.3 4515.2 4611.6 4687.3 2591.9 2604.0 2655.8 2826.4 2885.5 5175.9 5323.0 5670.5 5692.9 5715.5 4689.0 4790.4 5202.3 5616.4 5643.5 4721.6 5071.8 5096.6 5684.6 5713.7 4812.5 4845.6 5157.6 5174.7 5460.5 4805.4 5143.7 5330.9 5387.1 5484.8 4689.2 5121.3 5272.4 5455.9 5700.2 3271.4 3674.1 3750.8 3768.9 3771.6 4699.4 5142.7 5360.1 5389.6 5465.9 4611.6 4941.6 5236.6 5238.2 5275.8 4539.0 4721.0 4730.9 4790.0 5207.0 4612.5 4727.4 4781.9 4790.0 5180.6 5338.8 5451.7 5477.9 5481.6 5490.9 4962.5 5410.3 5427.4 5438.2 5476.5 16:48:18 INFO - PROCESS | 1635 | 16:48:18 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:21086.19 Median:3938.66 stddev:30761.84 (781.0%) stddev-sans-first:30810.22 16:48:18 INFO - PROCESS | 1635 | Values: 744.8 759.1 799.5 883.8 897.7 15318.7 15970.6 15978.8 15991.8 16009.9 14542.9 14617.6 14652.6 14677.7 14740.4 734.7 764.3 768.9 921.0 939.6 744.8 750.9 752.8 895.3 939.9 990.2 990.9 1000.7 1006.7 1008.3 996.9 999.8 999.9 1004.6 1007.8 744.3 745.3 746.6 748.7 749.1 14608.9 14667.1 14667.6 15922.0 16191.9 14477.1 14686.8 14943.7 14948.5 15232.3 10437.9 11713.4 11882.3 11900.3 12211.6 3796.8 3930.8 3946.5 3948.9 4093.6 106997.0 110199.0 111019.4 111421.0 112712.0 9092.4 9667.7 11315.5 11369.4 11861.5 24287.9 24297.5 24331.0 24335.5 24349.0 7138.2 7618.7 7939.3 8041.0 8182.5 4418.6 4532.4 4539.7 4582.1 4737.4 3696.4 3798.7 3799.2 3808.2 3812.5 670.6 673.3 708.7 718.8 719.2 583.0 697.3 742.5 746.4 750.7 10122.4 10511.2 10817.7 11016.8 11054.4 589.6 679.7 706.6 713.7 738.3 4132.2 5122.4 5138.1 5149.3 5152.5 75859.6 99176.0 109658.0 111197.4 111367.0 90169.5 94460.1 95233.5 96242.0 96279.5 81495.4 83754.0 83767.2 84917.6 84959.0 9800.6 9938.0 10018.3 10032.6 10049.8 53793.0 54234.0 54321.0 54569.5 55797.0 66043.0 72364.0 73531.0 73568.0 73796.0 12103.7 12349.7 12375.8 12430.9 12658.1 12979.9 13351.4 13415.8 13580.9 13985.4 12092.3 12408.9 12631.2 12694.9 12852.6 11908.4 12391.9 12565.8 12628.0 12845.2 11787.1 11972.8 12214.3 12290.6 12636.4 7918.0 9063.6 9321.4 9491.9 9622.7 10169.4 10248.7 10263.2 10263.6 10306.7 16:48:18 INFO - PROCESS | 1635 | -------- Summary: end -------- 16:48:18 INFO - PROCESS | 1635 | 16:48:19 INFO - TEST-INFO | 1635: exit 0 16:48:19 INFO - TEST-OK | dromaeo_css | took 1116256ms 16:48:19 INFO - TEST-START | kraken 16:48:19 INFO - operating with platform_type : mac_ 16:48:19 INFO - Initialising browser for kraken test... 16:48:19 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpegnpVO/profile http://localhost:49241/getInfo.html) 16:48:21 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 16:48:21 INFO - PROCESS | 1645 | colorDepth:24 16:48:21 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 16:48:21 INFO - PROCESS | 1645 | __metrics 16:48:21 INFO - PROCESS | 1645 | 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" 16:48:21 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:48:22 INFO - TEST-INFO | 1645: exit 0 16:48:22 INFO - Browser initialized. 16:48:22 INFO - Running cycle 1/1 for kraken test... 16:48:22 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpegnpVO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:34 INFO - PROCESS | 1647 | RSS: Main: 163926016 16:48:34 INFO - PROCESS | 1647 | 16:48:36 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 16:48:37 INFO - PROCESS | 1647 | RSS: Main: 213659648 16:48:37 INFO - PROCESS | 1647 | 16:48:40 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 16:48:40 INFO - PROCESS | 1647 | RSS: Main: 227893248 16:48:40 INFO - PROCESS | 1647 | 16:48:43 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 16:48:44 INFO - PROCESS | 1647 | RSS: Main: 324354048 16:48:44 INFO - PROCESS | 1647 | 16:48:46 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 16:48:46 INFO - PROCESS | 1647 | RSS: Main: 227995648 16:48:46 INFO - PROCESS | 1647 | 16:48:48 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:48:49 INFO - PROCESS | 1647 | RSS: Main: 231563264 16:48:49 INFO - PROCESS | 1647 | 16:48:52 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 16:48:52 INFO - PROCESS | 1647 | RSS: Main: 272609280 16:48:52 INFO - PROCESS | 1647 | 16:48:55 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 16:48:56 INFO - PROCESS | 1647 | RSS: Main: 270209024 16:48:56 INFO - PROCESS | 1647 | 16:48:59 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 16:48:59 INFO - PROCESS | 1647 | RSS: Main: 268115968 16:48:59 INFO - PROCESS | 1647 | 16:49:01 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:49:02 INFO - PROCESS | 1647 | RSS: Main: 245383168 16:49:02 INFO - PROCESS | 1647 | 16:49:03 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:49:04 INFO - PROCESS | 1647 | RSS: Main: 248487936 16:49:04 INFO - PROCESS | 1647 | 16:49:06 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:49:07 INFO - PROCESS | 1647 | RSS: Main: 251039744 16:49:07 INFO - PROCESS | 1647 | 16:49:10 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:49:10 INFO - PROCESS | 1647 | RSS: Main: 266334208 16:49:10 INFO - PROCESS | 1647 | 16:49:13 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:49:14 INFO - PROCESS | 1647 | RSS: Main: 259821568 16:49:14 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 16:49:16 INFO - PROCESS | 1647 | RSS: Main: 304287744 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | __start_tp_report 16:49:16 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 16:49:16 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 16:49:16 INFO - PROCESS | 1647 | |i|pagename|runs| 16:49:16 INFO - PROCESS | 1647 | |0;ai-astar;102;113;111;110;112;114;110;110;112;113 16:49:16 INFO - PROCESS | 1647 | |1;audio-beat-detection;140;106;105;142;107;106;106;104;137;106 16:49:16 INFO - PROCESS | 1647 | |2;audio-dft;182;184;179;184;181;178;182;182;182;182 16:49:16 INFO - PROCESS | 1647 | |3;audio-fft;81;57;57;87;61;57;57;57;74;57 16:49:16 INFO - PROCESS | 1647 | |4;audio-oscillator;87;70;85;69;68;68;80;66;68;82 16:49:16 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;87;85;87;83;86;83;87;85;87;90 16:49:16 INFO - PROCESS | 1647 | |6;imaging-darkroom;94;93;94;94;93;93;93;93;93;93 16:49:16 INFO - PROCESS | 1647 | |7;imaging-desaturate;84;86;89;87;86;88;86;100;138;129 16:49:16 INFO - PROCESS | 1647 | |8;json-parse-financial;54;53;52;51;55;56;56;56;53;53 16:49:16 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;63;69;75;75;72;67;68;70;68;69 16:49:16 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;81;94;98;100;98;100;80;81;83;91 16:49:16 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;130;142;143;137;143;135;134;135;163;131 16:49:16 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;164;162;167;162;161;205;160;160;160;157 16:49:16 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;65;64;66;65;63;63;63;63;64;64 16:49:16 INFO - PROCESS | 1647 | __end_tp_report 16:49:16 INFO - PROCESS | 1647 | __start_cc_report 16:49:16 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1932 16:49:16 INFO - PROCESS | 1647 | __end_cc_report 16:49:16 INFO - PROCESS | 1647 | __startTimestamp1491349756336__endTimestamp 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | ------- Summary: start ------- 16:49:16 INFO - PROCESS | 1647 | Number of tests: 14 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.37 (3.0%) stddev-sans-first:1.50 16:49:16 INFO - PROCESS | 1647 | Values: 102.0 113.0 111.0 110.0 112.0 114.0 110.0 110.0 112.0 113.0 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:115.90 Median:106.50 stddev:16.46 (15.5%) stddev-sans-first:14.97 16:49:16 INFO - PROCESS | 1647 | Values: 140.0 106.0 105.0 142.0 107.0 106.0 106.0 104.0 137.0 106.0 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:181.60 Median:182.00 stddev:1.90 (1.0%) stddev-sans-first:2.01 16:49:16 INFO - PROCESS | 1647 | Values: 182.0 184.0 179.0 184.0 181.0 178.0 182.0 182.0 182.0 182.0 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:64.50 Median:59.00 stddev:11.64 (19.7%) stddev-sans-first:10.70 16:49:16 INFO - PROCESS | 1647 | Values: 81.0 57.0 57.0 87.0 61.0 57.0 57.0 57.0 74.0 57.0 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:74.30 Median:75.00 stddev:8.18 (10.9%) stddev-sans-first:7.27 16:49:16 INFO - PROCESS | 1647 | Values: 87.0 70.0 85.0 69.0 68.0 68.0 80.0 66.0 68.0 82.0 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:87.00 stddev:2.11 (2.4%) stddev-sans-first:2.20 16:49:16 INFO - PROCESS | 1647 | Values: 87.0 85.0 87.0 83.0 86.0 83.0 87.0 85.0 87.0 90.0 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 16:49:16 INFO - PROCESS | 1647 | Values: 94.0 93.0 94.0 94.0 93.0 93.0 93.0 93.0 93.0 93.0 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:86.00 stddev:19.69 (22.9%) stddev-sans-first:20.29 16:49:16 INFO - PROCESS | 1647 | Values: 84.0 86.0 89.0 87.0 86.0 88.0 86.0 100.0 138.0 129.0 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.50 stddev:1.79 (3.3%) stddev-sans-first:1.90 16:49:16 INFO - PROCESS | 1647 | Values: 54.0 53.0 52.0 51.0 55.0 56.0 56.0 56.0 53.0 53.0 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.50 stddev:3.66 (5.3%) stddev-sans-first:3.00 16:49:16 INFO - PROCESS | 1647 | Values: 63.0 69.0 75.0 75.0 72.0 67.0 68.0 70.0 68.0 69.0 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:87.00 stddev:8.51 (9.8%) stddev-sans-first:8.29 16:49:16 INFO - PROCESS | 1647 | Values: 81.0 94.0 98.0 100.0 98.0 100.0 80.0 81.0 83.0 91.0 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:139.50 stddev:9.56 (6.9%) stddev-sans-first:9.53 16:49:16 INFO - PROCESS | 1647 | Values: 130.0 142.0 143.0 137.0 143.0 135.0 134.0 135.0 163.0 131.0 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:162.00 stddev:14.03 (8.7%) stddev-sans-first:14.87 16:49:16 INFO - PROCESS | 1647 | Values: 164.0 162.0 167.0 162.0 161.0 205.0 160.0 160.0 160.0 157.0 16:49:16 INFO - PROCESS | 1647 | 16:49:16 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:1.05 (1.6%) stddev-sans-first:1.05 16:49:16 INFO - PROCESS | 1647 | Values: 65.0 64.0 66.0 65.0 63.0 63.0 63.0 63.0 64.0 64.0 16:49:16 INFO - PROCESS | 1647 | -------- Summary: end -------- 16:49:16 INFO - PROCESS | 1647 | 16:49:17 INFO - TEST-INFO | 1647: exit 0 16:49:17 INFO - TEST-OK | kraken | took 57913ms 16:49:17 INFO - SUITE-END | took 1174s 16:49:17 INFO - Completed test suite (00:19:34) 16:49:17 INFO - javascript benchmark 16:49:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.2351912022, 3511.3679537683224, 3523.365555395247, 3526.8236588170585, 3579.67782899539, 5809.535237181026, 5810.767569297228, 5858.41415858415, 5864.208331875196, 5893.116032595108, 5830.125481177825, 5859.414058594139, 5875.676837773932, 5888.882222355551, 5903.4686878180955, 5290.867728306804, 5350.30446042014, 5351.946480535184, 5381.246625472418, 5419.268398766175, 5286.577073834103, 5289.021531016755, 5295.7881684732565, 5295.973520132413, 5323.707196104213, 5376.865578360533, 5399.37907140678, 5405.864853378677, 5409.729513524328, 5436.293281873351, 5381.327334083239, 5385.569154467633, 5399.676019438807, 5403.297571315743, 5452.482014208644, 5151.5106064923775, 5247.317848679685, 5263.078961181778, 5307.310049693554, 5310.840674779763, 5802.941970580282, 5827.213326200994, 5850.0932355484965, 5877.67672777997, 5932.377100404482, 6332.050192471166, 6342.460890824285, 6367.936320636781, 6378.394052564999, 6405.519586031066, 5989.13157592151, 6158.630482171084, 6268.091126786636, 6345.873082538324, 6350.174477317965, 5835.183074369592, 5967.671778052206, 6002.909956350658, 6006.669633170174, 6094.756209751649, 6337.017762246859, 6384.329645387167, 6390.0734393512685, 6406.775762848278, 6408.903866442007, 6273.780417685359, 6323.9683801580695, 6343.207099112611, 6345.587536810092, 6353.809385718436, 4372.672049596229, 6248.125262463259, 6289.811305660837, 6299.0, 6301.212348456443, 6355.237371515355, 6372.107904893319, 6376.617402955838, 6385.6487893165395, 6399.456046236029, 6301.558890877594, 6302.369763023661, 6307.5584709070845, 6339.873202535923, 6362.141110949962, 5000.2749601307605, 5027.698338099725, 5027.949720502821, 5035.320231768665, 5042.39491261051, 4548.522405147478, 4576.97711511447, 4581.0, 4589.380433641482, 4621.792019359137, 5889.440503152194, 5928.199693041471, 5942.257217847769, 5948.196993405835, 5960.910586341209, 6125.937554509019, 6218.19163508741, 6342.651154186472, 6350.4602108820345, 6357.982722764335, 5810.88378232433, 5834.27071616048, 5873.559483038789, 5880.176775251468, 5904.911426328608, 5457.263269458652, 5515.365732940683, 5531.0, 5542.695151766611, 5570.220169176318, 6217.4715149212825, 6390.648514331757, 6391.584547004616, 6398.616083035033, 6411.775587854403, 6221.626702397871, 6239.844003899939, 6254.468370188403, 6322.3045464997895, 6323.399277068671, 6396.42432181106, 6408.134901788386, 6413.422791948747, 6419.775307864203, 6426.357364263723, 6326.873462530815, 6336.493080553637, 6351.618902865843, 6354.428101470705, 6370.522210834299, 6230.065490176328, 6231.096491008869, 6249.125122482947, 6256.155419018374, 6290.937090629035, 4582.175208462509, 6005.759769609342, 6263.843403914939, 6296.905546416716, 6300.054991751274, 6185.381461853779, 6240.157578726814, 6253.812385628438, 6255.093011513396, 6256.624602523863, 4445.37764712947, 6025.578209525466, 6059.787907423219, 6087.178230938944, 6181.381861813783, 6142.989934931762, 6232.8130156095385, 6257.874842503215, 6272.372762723691, 6280.434760871543, 5997.4002599741425, 6058.363871793398, 6107.358727333566, 6126.754929802758, 6132.509399247961], "value": 5799.7320023210505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.1687358662932, 533.7197971065191, 551.3218740948633, 552.1827695011381, 559.5758793869602, 32758.836205818967, 42719.572804271986, 44174.779126104324, 44365.33451998223, 46705.0, 46124.07751844961, 46309.0, 46930.53069469304, 47049.0, 47078.52921470784, 8930.062343453941, 9452.0, 9676.371035882645, 9680.031996800333, 9690.46702431366, 8973.371863969525, 9178.86231706525, 9182.540872956359, 9183.403078799856, 11695.239809412362, 11762.00022998042, 11908.880911190907, 11910.7617847643, 11926.045916326717, 11957.820632690517, 11710.824337634942, 11786.410679465993, 11793.705157371049, 11801.409929503534, 11817.0, 11682.532698692043, 11741.354225517593, 11749.530018799238, 11779.411029448578, 11784.469698863571, 42197.0, 42482.57517424848, 42527.787361063, 42550.7234782957, 42612.57387426117, 4055.6755459563165, 4069.308217603015, 4106.507219133723, 4116.9794151029355, 4127.731697439657, 30515.542266866014, 30649.540256896165, 32029.039128825938, 32504.02487925366, 33101.00696979094, 3182.379436009979, 3207.631122420905, 3320.3027364253535, 3332.96667033329, 3436.621971583124, 504623.0, 506115.0, 506910.0, 509770.0, 510054.4497277527, 68437.65781171063, 68673.999999999, 68782.0, 69262.0, 69282.65358673275, 72037.63981180165, 72078.63960680163, 72146.9177962331, 72166.63916680383, 72176.91734623985, 17503.73744393835, 18140.818591814175, 18149.7277540837, 18178.818211817714, 18180.0, 13773.311334433238, 13865.653358666113, 13885.791713124312, 13887.58337249884, 13900.860991390158, 16705.6658866822, 17113.914430428016, 17161.399351022654, 17334.739978900325, 18273.105889368773, 6239.625622462667, 6244.875102498016, 6254.624722516573, 6266.717997690115, 7339.74310899116, 906.6101576322245, 909.6179604566098, 915.555955361649, 933.6032186320787, 948.2840455456087, 31475.213119672193, 32664.510032349535, 34607.82696086554, 34703.9588812336, 35199.296014080086, 905.307439808547, 1012.5747186181821, 1114.2590177531852, 1117.9826358014168, 1222.786012447836, 16034.358625654842, 16124.838751612333, 16377.836221637632, 16396.344146234256, 17031.953656452028, 535290.0, 673181.0, 677978.0, 678820.0, 679114.0, 47434.762826186336, 51871.0, 52959.0, 58775.41224587785, 59298.70350648219, 1526.7862499250114, 1551.8525740054677, 1559.2281820498927, 1575.4249698859833, 1575.8345373735592, 28851.56722649204, 30513.542296865122, 32769.50845737364, 32927.341453170324, 33627.15932101717, 46763.766181170235, 47015.0, 53133.46866531285, 57625.423745763685, 57638.7118064407, 623192.0, 652646.0, 667350.0, 882765.0, 895054.5247273722, 44036.559634403246, 44291.67124986256, 44422.0, 44505.0, 44569.33146002878, 49344.50655493399, 49965.0, 50213.74893125511, 50896.23655645242, 51040.74479627578, 33200.011998920214, 33893.152671183416, 33995.66004339925, 34003.829980850925, 34948.30103397867, 33502.49746253759, 33678.66321336755, 33730.66269337275, 34244.48633270553, 34470.138246543036, 38954.2209155821, 39892.60107398889, 40029.0, 40337.0, 40348.79825600853, 32882.17794555155, 33312.83405080908, 33621.83189084039, 33879.66120338765, 34624.615015399104, 19772.30796922101, 26252.243514431473, 26282.652377763046, 26340.736592633828, 27043.86478067597], "value": 21307.159144213758, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.7669408108405, 407.5781566079108, 411.12430522986074, 417.63039709856787, 437.6892406391462, 21304.680429793567, 21433.57132857344, 21559.784402155972, 22057.669134962947, 22259.332220033404, 22184.223552175677, 22608.0, 23286.767132328714, 23425.0, 23667.763322366773, 5786.999999999989, 6017.518598512109, 6075.392460753911, 6091.269047714259, 6095.908561371561, 5768.653880767147, 5895.086261629454, 5936.465718085371, 5999.340072592011, 6013.639181649115, 5955.910661340062, 5962.73167707452, 5969.791057312995, 5970.970145149268, 5971.940280597182, 5724.055530837407, 5869.941300586982, 5934.5845790794665, 5948.405159484017, 5949.7025148742605, 5026.47222041684, 5255.395629502618, 5261.368635763694, 5268.604854635918, 5271.789128434858, 23342.76657233423, 23778.762212377827, 23810.64284035741, 27115.864420677968, 27130.914763409637, 2722.7005029446746, 2735.904243351493, 2754.862256887148, 2759.503289407906, 2767.5848622706553, 16441.26014329358, 16570.337186512526, 16597.66804663912, 16692.41576544815, 17047.659046819117, 1835.5104111742323, 1897.2790339670976, 1912.6557219700449, 1920.395075551197, 1922.8942408167545, 128633.0, 131155.0, 136185.319073405, 137188.0, 137734.0, 11607.76784464323, 11811.350375729417, 11837.171398002229, 11996.280223186637, 12002.399880005965, 15436.382544698086, 15474.845251547566, 15487.0, 15490.225488725519, 15519.767203491956, 7791.104023037423, 9037.548122593844, 9082.31882608807, 9267.907320926839, 9270.72187834366, 9148.359614826899, 9152.757574394316, 9184.448933064037, 9321.254299656146, 9350.298727595458, 7329.743458979016, 7561.09266887966, 7569.129550101698, 7606.163322034572, 7623.695052197961, 1757.5606098475382, 1959.480737604536, 1984.0, 1996.5008747813047, 1998.4803950972853, 798.872180451125, 1039.0544604410102, 1054.1250761867632, 1074.693712291993, 1140.520981187903, 20448.795512044988, 24008.15971440991, 24169.154079607128, 24584.139555115486, 24601.753982460305, 1086.3699054548342, 1106.5573770491867, 1106.773111512138, 1118.2100658856207, 1133.393634405589, 11698.532058717727, 11968.880311196777, 12485.50057997688, 12630.747385052247, 12642.2414655121, 799353.0, 830553.0, 835766.0, 836244.8187759144, 839844.0, 151306.0, 157306.0, 158449.41550584577, 159762.0, 163116.1844190795, 1056.6882769582992, 1080.735219871121, 1110.3781882146025, 1111.7331840358256, 1117.5362224676994, 16885.0, 19546.628064886627, 20749.89625051865, 20909.790902090783, 20937.581248375252, 58463.0, 58779.0, 59501.702491489, 60821.0, 61263.0, 86916.0, 87922.56038719765, 88626.0, 90165.0, 91155.54422227846, 8474.788130296793, 8567.4002819802, 8646.870296945424, 8810.647574096964, 8872.201501864864, 11262.099032077578, 12336.198147120409, 13212.207267563977, 13242.53651122206, 13584.45662173502, 11299.830502542633, 11581.7104572383, 11597.072234221074, 11704.590339338083, 11769.470373833026, 10687.091597214323, 10691.465426728477, 10813.56745730162, 10823.621173258898, 11033.668989930315, 11295.548178072784, 11621.593244236412, 11668.241564298633, 11956.880431195925, 11986.981106606036, 8536.74389768308, 8552.615132318937, 8609.569521523774, 8754.562271886507, 8876.911230887608, 11389.829152562552, 11406.771864562828, 11474.311541307548, 11734.178607497735, 11816.645500634995], "value": 10548.116663100847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1118.2228351295848, 1143.5540139345658, 1143.6511863881524, 1149.0807354116705, 1215.981760273596, 8238.546879921601, 8624.051354351024, 8626.396152269344, 8635.568221588926, 8645.78385540361, 7541.434392420563, 7757.49576277543, 7763.534187948727, 8041.758747237577, 8391.70629027984, 2333.6966194394704, 2432.1852179519883, 2436.5735996200683, 2442.1818690738623, 2449.5223431430877, 2409.084547871815, 2443.4135807406183, 2453.2272334214667, 2461.163204510466, 2465.4329504214043, 1777.8755487115843, 2096.4758810297426, 2211.447138215446, 2224.2993457060975, 2225.521512874732, 2203.460152262698, 2331.347222777625, 2407.6749638798715, 2414.3239892830034, 2421.2131057406414, 2404.8797560121925, 2415.577273977047, 2416.2147302126705, 2431.416460049593, 2435.756424357568, 8383.664653413916, 8415.0, 8473.661053557851, 8474.406791524596, 8482.448640838387, 5220.295260139908, 5371.301730774974, 5372.811951581715, 5377.0, 5382.703951282678, 3548.574171099459, 3557.6086630470627, 3608.657177568127, 3638.2177831766035, 3649.4160934250394, 1248.650377894182, 1280.327827890365, 1284.800855867342, 1299.5776372678918, 1324.6622111361637, 9336.626534938594, 10667.519961601747, 10812.0, 10910.181736369805, 10919.836202456969, 4710.858674239778, 4775.2598347256235, 4822.469528351879, 4863.975680121577, 4867.537583929521, 9686.854697179548, 9688.806223875625, 9703.320767546204, 9716.854247186298, 9718.805623887483, 5329.680219186861, 5392.595555333366, 5413.702246376409, 5422.945770542244, 5440.347158341025, 4700.130475861976, 4807.278908163804, 4861.611071114302, 4949.752512374367, 4977.303177555145, 3784.6215378462484, 3849.4418309344987, 3872.7095467839463, 3901.941470877939, 3904.7266691331333, 1194.474431250247, 1195.54569263681, 1199.8320235167084, 1208.3233389301843, 1208.8549374074992, 797.8085259537669, 917.775145089444, 920.7974245665943, 929.3215952354819, 938.6996161228342, 5366.168243922199, 5728.341240757366, 5771.711414429262, 5920.319163296276, 5949.3455719871645, 942.853857652065, 1003.2124782046059, 1028.943408112561, 1031.2159963263596, 1075.7525769073156, 3732.309522738302, 3879.359905615598, 3886.145048089416, 3901.3367727486398, 4092.836286548564, 9431.952840235756, 9613.423194608346, 9708.805823883624, 9717.514124293757, 9724.805503889882, 9434.528273586293, 9601.087896649808, 9621.9037809621, 9824.607015719434, 9827.164691001202, 7698.114716807639, 7872.17342179063, 7880.921190788019, 7897.881531777028, 7916.168802275678, 5362.249285100167, 5639.351474580476, 5647.745851436777, 5893.019937373637, 5982.102684597346, 9354.298427618092, 9392.060793920553, 9421.38760980534, 9436.905630943877, 9441.008694087022, 8774.429662071945, 9273.072692730673, 9414.95292523533, 9574.377665451724, 9580.658707781056, 6799.150106236721, 7187.532810367309, 7279.235680253497, 7371.483996120434, 7404.222556631476, 7789.766307010798, 7975.481593696391, 8080.71717489885, 8083.757487275391, 8174.264316211569, 7072.151341839012, 7124.465665075244, 7148.857022859618, 7173.426125910019, 7198.0, 6965.860682786215, 7001.4748893834185, 7025.192102908231, 7077.009218709281, 7152.85694286101, 6461.321561236191, 6493.837654058686, 6581.44057755077, 6583.242927063449, 6597.109390232257, 4343.391925130548, 5010.323606313101, 5030.37120359955, 5178.456262092426, 5303.310569625924, 4675.649326300609, 5043.445221025758, 5115.897682046412, 5137.1010073237785, 5282.366116066097], "value": 4466.209490955891, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.18818869750436, 375.6056141051895, 380.9257194847005, 390.8026446644444, 392.0766594669555, 4754.930140718341, 5088.0587091388115, 5271.841844744654, 5283.996040752259, 5355.732213389325, 4052.4731784868, 4678.602318802906, 4735.73953432561, 5008.595873980492, 5147.279380886669, 3763.623637636228, 3816.637419445148, 3997.960020399788, 4118.546959834423, 4196.9370459443135, 4131.690123240754, 4133.7106402551835, 4177.707560470768, 4193.832246710143, 4219.017061980864, 3584.677379035886, 3660.4143337066075, 3828.7511311764783, 4121.835126594948, 4168.8332466701295, 4087.1621317629965, 4108.5275193352545, 4136.937945930814, 4144.564820693844, 4150.771707556083, 3150.149459645883, 3669.7064234861145, 3695.7597756145765, 3709.9072523186865, 3710.350688629479, 4835.734034628094, 4879.926801097987, 5185.325907632021, 5239.318888544465, 5240.3973543042275, 4219.831206751726, 4621.8445388652835, 4649.628029757645, 4655.348251244828, 4668.626509879202, 4949.267756285308, 4960.528749768766, 5560.304961879765, 5587.469190426903, 5622.088489913408, 3457.75246090041, 3895.3962135868987, 3903.8243279052513, 3918.1380096378753, 3927.9803600981813, 4936.703797772145, 5495.642783219078, 5771.249737534094, 5803.912941305884, 5827.854303642358, 3440.8301177599737, 3876.903077423087, 3899.0, 3924.0189952511873, 3952.3281042222893, 3968.523777146703, 3984.1353886729826, 4011.6389524942897, 4017.9397309040387, 4047.817848196838, 3768.510093687803, 3919.6668283195677, 4532.229520981441, 4556.749378784132, 4599.356090147382, 4875.366202393666, 4949.604031677529, 5304.92042619361, 5576.776928922879, 5648.8870222595315, 1246.6820960655157, 1282.8588855225917, 1298.3313593499356, 1302.257713103541, 1305.2494815481136, 839.0450250915353, 846.6147902704255, 864.6022829498501, 883.726044926075, 884.5179377239419, 4268.40242366069, 4428.601425871622, 4750.978539614, 4796.424429068465, 4982.626303027288, 4559.3844830948065, 5121.641485096007, 5411.675299482044, 5469.453054694499, 5546.251256080377, 4203.432536607519, 4504.25679762842, 4515.164694531457, 4611.618961986127, 4687.250039993584, 2591.9352016199746, 2604.0234911908033, 2655.8048878004975, 2826.3781967967016, 2885.5383138697707, 5175.948240517622, 5323.0152421802095, 5670.489655930986, 5692.943070569241, 5715.5427565794635, 4688.953110468851, 4790.449098353664, 5202.3497062867145, 5616.354119276254, 5643.548516118701, 4721.6458765592715, 5071.847844564669, 5096.592272618182, 5684.573656975744, 5713.6857472838565, 4812.494688057844, 4845.612351011981, 5157.581665042144, 5174.663646862942, 5460.525658072378, 4805.423349198119, 5143.71709555978, 5330.920036199538, 5387.084195686664, 5484.753186106715, 4689.249720044776, 5121.257417674491, 5272.420033796203, 5455.9454405455435, 5700.230468886647, 3271.411145993649, 3674.0998455378603, 3750.780996176199, 3768.924621507609, 3771.6039815818945, 4699.3890794197905, 5142.742862856917, 5360.115580929259, 5389.62272640927, 5465.918011229755, 4611.6310695144975, 4941.579965702956, 5236.581073514186, 5238.188080847474, 5275.815346462856, 4539.024109816405, 4721.0493441599, 4730.935539503585, 4789.970156416387, 5206.984637995554, 4612.465041949741, 4727.409073865767, 4781.915664396514, 4789.976050119727, 5180.61145414103, 5338.759755811076, 5451.7274136292235, 5477.890442191054, 5481.588880834033, 5490.890182196414, 4962.528559786814, 5410.323709536308, 5427.398917319321, 5438.211459338453, 5476.452354764491], "value": 3968.633929979083, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.7728442824937, 759.0625577411898, 799.5282783157936, 883.7878909061826, 897.6678628907305, 15318.693626127484, 15970.600734981617, 15978.76031859523, 15991.760123598126, 16009.919950400246, 14542.854571454282, 14617.561473155822, 14652.633684157901, 14677.706445871076, 14740.41038358467, 734.7244783206297, 764.2815753192009, 768.9307962283393, 920.9915142918494, 939.5537119868043, 744.7691215723116, 750.9436792240576, 752.7553545097837, 895.2837729816121, 939.9154076133146, 990.227622454483, 990.9058639429243, 1000.7448100734302, 1006.733215697837, 1008.334499230508, 996.9401835889797, 999.8200323941687, 999.9200063994863, 1004.5730564510054, 1007.788364443464, 744.3375395897656, 745.3105877063695, 746.5520687587405, 748.6556184155295, 749.1310080306818, 14608.926955365261, 14667.119972801665, 14667.559973200821, 15922.0, 16191.947523411058, 14477.131372117707, 14686.779698304534, 14943.701125977419, 14948.476803311833, 15232.314545845464, 10437.895621043845, 11713.39812012108, 11882.346470944094, 11900.285982840971, 12211.572594959134, 3796.8481260749536, 3930.78380689062, 3946.5461471930807, 3948.861789837342, 4093.5906409358827, 106997.0, 110199.0, 111019.44490277578, 111421.0, 112711.99999999919, 9092.408993415407, 9667.661631842993, 11315.547378104948, 11369.374684392273, 11861.525538978516, 24287.878560607085, 24297.514049718906, 24331.0267589298, 24335.513289734106, 24349.026038958244, 7138.179109402381, 7618.657160427794, 7939.3251573615735, 8041.0, 8182.509049457051, 4418.624416924533, 4532.388127602798, 4539.682222244412, 4582.060677561092, 4737.360456338419, 3696.4085746281003, 3798.6771124454176, 3799.2211596622624, 3808.1812410331913, 3812.4853144825647, 670.5909395268882, 673.3434900971612, 708.6633848921824, 718.8202949262684, 719.1801346465035, 582.994170058294, 697.2992142896356, 742.4876834983952, 746.4101463882005, 750.6622020090981, 10122.443265620313, 10511.211659125596, 10817.675469735921, 11016.779664406668, 11054.392008439612, 589.5607772209731, 679.6975345970995, 706.593708617547, 713.7216485570632, 738.3281214095255, 4132.235536425711, 5122.436531981479, 5138.12651849179, 5149.253358263106, 5152.458991805881, 75859.62070189614, 99176.0, 109658.0, 111197.44401278104, 111367.0, 90169.54915225382, 94460.05539944513, 95233.52383238178, 96242.0, 96279.51860240653, 81495.370092599, 83754.0, 83767.16232837837, 84917.57541212255, 84959.0, 9800.59249670138, 9938.0, 10018.3488073275, 10032.64885728996, 10049.849252261076, 53793.0, 54234.0, 54321.0, 54569.45430545803, 55796.97827195572, 66043.0, 72364.0, 73531.0, 73568.0, 73796.0, 12103.697407564881, 12349.691257718629, 12375.814362784746, 12430.937845310715, 12658.050646201757, 12979.870201297867, 13351.3991870368, 13415.798763018367, 13580.864191358356, 13985.370658320197, 12092.274463532216, 12408.875911241134, 12631.178973366701, 12694.936525317315, 12852.55016074433, 11908.40457977115, 12391.876081239072, 12565.811512827133, 12628.0, 12845.229286242855, 11787.115966302734, 11972.76054478923, 12214.26714397139, 12290.631281061582, 12636.43136058898, 7918.0, 9063.592138353659, 9321.394109382869, 9491.905080949102, 9622.711318660451, 10169.440680762333, 10248.692539223835, 10263.23025773055, 10263.640772572924, 10306.690799276033], "value": 7645.795589525342, "unit": "score"}], "name": "dromaeo_css", "value": 7490.782857491143, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 111.0, 110.0, 112.0, 114.0, 110.0, 110.0, 112.0, 113.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 106.0, 105.0, 142.0, 107.0, 106.0, 106.0, 104.0, 137.0, 106.0], "value": 115.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 179.0, 184.0, 181.0, 178.0, 182.0, 182.0, 182.0, 182.0], "value": 181.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 57.0, 87.0, 61.0, 57.0, 57.0, 57.0, 74.0, 57.0], "value": 64.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 85.0, 69.0, 68.0, 68.0, 80.0, 66.0, 68.0, 82.0], "value": 74.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 83.0, 86.0, 83.0, 87.0, 85.0, 87.0, 90.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 89.0, 87.0, 86.0, 88.0, 86.0, 100.0, 138.0, 129.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 51.0, 55.0, 56.0, 56.0, 56.0, 53.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 75.0, 75.0, 72.0, 67.0, 68.0, 70.0, 68.0, 69.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 94.0, 98.0, 100.0, 98.0, 100.0, 80.0, 81.0, 83.0, 91.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 142.0, 143.0, 137.0, 143.0, 135.0, 134.0, 135.0, 163.0, 131.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 167.0, 162.0, 161.0, 205.0, 160.0, 160.0, 160.0, 157.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 65.0, 63.0, 63.0, 63.0, 63.0, 64.0, 64.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1406.7999999999997, "alertThreshold": 2.0}]} 16:49:17 INFO - Return code: 0 16:49:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:49:17 INFO - # TBPL SUCCESS # 16:49:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:49:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:49:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:49:17 INFO - 2017-04-04 16:49:17.681 screenresolution[1651:9560] starting screenresolution argv=screenresolution get 16:49:17 INFO - 2017-04-04 16:49:17.684 screenresolution[1651:9560] Display 0: 1600x1200x32@60 16:49:17 INFO - 2017-04-04 16:49:17.691 screenresolution[1652:9563] starting screenresolution argv=screenresolution list 16:49:17 INFO - Available Modes on Display 0 16:49:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:49:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:49:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:49:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:49:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:49:17 INFO - Intel Iris: 16:49:17 INFO - Chipset Model: Intel Iris 16:49:17 INFO - Type: GPU 16:49:17 INFO - Bus: Built-In 16:49:17 INFO - VRAM (Dynamic, Max): 1536 MB 16:49:17 INFO - Vendor: Intel (0x8086) 16:49:17 INFO - Device ID: 0x0a2e 16:49:17 INFO - Revision ID: 0x0009 16:49:17 INFO - Displays: 16:49:17 INFO - Display: 16:49:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:49:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:49:17 INFO - Display Serial Number: 1600x1200 60 16:49:17 INFO - Main Display: Yes 16:49:17 INFO - Mirror: Off 16:49:17 INFO - Online: Yes 16:49:17 INFO - Rotation: Supported 16:49:17 INFO - Return code: 0 16:49:17 INFO - Running post-action listener: _resource_record_post_action 16:49:17 INFO - [mozharness: 2017-04-04 23:49:17.928706Z] Finished run-tests step (success) 16:49:17 INFO - Running post-run listener: _resource_record_post_run 16:49:17 INFO - Total resource usage - Wall time: 1189s; CPU: 54.0%; Read bytes: 38142976; Write bytes: 418308608; Read time: 246; Write time: 1340 16:49:17 INFO - TinderboxPrint: CPU usage
53.8% 16:49:17 INFO - TinderboxPrint: I/O read bytes / time
38,142,976 / 246 16:49:17 INFO - TinderboxPrint: I/O write bytes / time
418,308,608 / 1,340 16:49:17 INFO - TinderboxPrint: CPU idle
2,196.8 (46.2%) 16:49:17 INFO - TinderboxPrint: CPU system
955.4 (20.1%) 16:49:17 INFO - TinderboxPrint: CPU user
1,605.4 (33.7%) 16:49:17 INFO - TinderboxPrint: Swap in / out
160,088,064 / 0 16:49:17 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 113607168; Write bytes: 112754688; Read time: 10126; Write time: 244 16:49:18 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 37196800; Write bytes: 295662080; Read time: 230; Write time: 1067 16:49:18 INFO - Running post-run listener: _upload_blobber_files 16:49:18 INFO - Blob upload gear active. 16:49:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:49:18 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 16:49:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:49:18 INFO - (blobuploader) - INFO - Open directory for files ... 16:49:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:49:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:49:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:19 INFO - (blobuploader) - INFO - Done attempting. 16:49:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:49:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:49:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:20 INFO - (blobuploader) - INFO - Done attempting. 16:49:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:49:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:49:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:21 INFO - (blobuploader) - INFO - Done attempting. 16:49:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:49:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:49:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:23 INFO - (blobuploader) - INFO - Done attempting. 16:49:23 INFO - (blobuploader) - INFO - Iteration through files over. 16:49:23 INFO - Return code: 0 16:49:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:49:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:49:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ea97a6637d411d4862cfeb3d3f6bd987695d5fd34d2dcda1659a2c0bad949e825c8a1d484e357130088022f2150210c99b11a3235e388bd0a256d0842ee17d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3df6575b5eda48664f7e2669a444d8c44c21c94d167a10275156ddd85cbc2573dd22963a272d785e26c46da631782af55e7e7a95d9b4eafdc62431190081c86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d08ee122e51c64f85d8bc05b4dcf1bdb6a31a729e17f48585dd8240c3ae62838d7c3b5b1b398b49eab75a889c71df600890d266f0fe1d6052ae3cfc4453dc56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9904521d23dbec699b5fc6d22d46cb4d0946f13737bed57385977899c0fe442924108206920e1725baa5ea91a9bb26ebd92e688fb7533e1c61d184462e5d654e"} 16:49:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:49:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:49:23 INFO - Contents: 16:49:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ea97a6637d411d4862cfeb3d3f6bd987695d5fd34d2dcda1659a2c0bad949e825c8a1d484e357130088022f2150210c99b11a3235e388bd0a256d0842ee17d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3df6575b5eda48664f7e2669a444d8c44c21c94d167a10275156ddd85cbc2573dd22963a272d785e26c46da631782af55e7e7a95d9b4eafdc62431190081c86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d08ee122e51c64f85d8bc05b4dcf1bdb6a31a729e17f48585dd8240c3ae62838d7c3b5b1b398b49eab75a889c71df600890d266f0fe1d6052ae3cfc4453dc56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9904521d23dbec699b5fc6d22d46cb4d0946f13737bed57385977899c0fe442924108206920e1725baa5ea91a9bb26ebd92e688fb7533e1c61d184462e5d654e"} 16:49:23 INFO - Running post-run listener: copy_logs_to_upload_dir 16:49:23 INFO - Copying logs to upload dir... 16:49:23 INFO - mkdir: /builds/slave/test/build/upload/logs 16:49:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.888607 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-04-04 16:49:23.458482) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 16:49:23.462838) ========= 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.a6eQNYR9lx/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.Suxmwzu5fP/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ea97a6637d411d4862cfeb3d3f6bd987695d5fd34d2dcda1659a2c0bad949e825c8a1d484e357130088022f2150210c99b11a3235e388bd0a256d0842ee17d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3df6575b5eda48664f7e2669a444d8c44c21c94d167a10275156ddd85cbc2573dd22963a272d785e26c46da631782af55e7e7a95d9b4eafdc62431190081c86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d08ee122e51c64f85d8bc05b4dcf1bdb6a31a729e17f48585dd8240c3ae62838d7c3b5b1b398b49eab75a889c71df600890d266f0fe1d6052ae3cfc4453dc56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9904521d23dbec699b5fc6d22d46cb4d0946f13737bed57385977899c0fe442924108206920e1725baa5ea91a9bb26ebd92e688fb7533e1c61d184462e5d654e"} build_url:https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010907 build_url: 'https://queue.taskcluster.net/v1/task/I6pwP8tCTI6E16lBuErKnw/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ea97a6637d411d4862cfeb3d3f6bd987695d5fd34d2dcda1659a2c0bad949e825c8a1d484e357130088022f2150210c99b11a3235e388bd0a256d0842ee17d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3df6575b5eda48664f7e2669a444d8c44c21c94d167a10275156ddd85cbc2573dd22963a272d785e26c46da631782af55e7e7a95d9b4eafdc62431190081c86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d08ee122e51c64f85d8bc05b4dcf1bdb6a31a729e17f48585dd8240c3ae62838d7c3b5b1b398b49eab75a889c71df600890d266f0fe1d6052ae3cfc4453dc56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9904521d23dbec699b5fc6d22d46cb4d0946f13737bed57385977899c0fe442924108206920e1725baa5ea91a9bb26ebd92e688fb7533e1c61d184462e5d654e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 16:49:23.497216) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 16:49:23.500575) ========= 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.a6eQNYR9lx/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.Suxmwzu5fP/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.004801 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 16:49:23.549315) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 16:49:23.552663) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 16:49:23.552999) ========= ========= Total master_lag: 0.75 =========