builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0190 starttime: 1483807736.03 results: success (0) buildid: 20170107063756 builduid: 7922d12289e54cae8367033373c24d57 revision: 58e5b3c7bdaf6e60a50c7a59c7105a0eb5dd0c2d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 08:48:56.031417) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 08:48:56.031808) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 08:48:56.032099) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 08:48:56.090266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:48:56.090665) ========= 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.RxFDWdNRDK/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.0R86a1HTzT/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-07 08:48:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 166M=0s 2017-01-07 08:48:56 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.463835 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:48:56.588840) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:48:56.589148) ========= 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.RxFDWdNRDK/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.0R86a1HTzT/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.027103 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:48:56.638374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-07 08:48:56.638720) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 58e5b3c7bdaf6e60a50c7a59c7105a0eb5dd0c2d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 58e5b3c7bdaf6e60a50c7a59c7105a0eb5dd0c2d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RxFDWdNRDK/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.0R86a1HTzT/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-07 08:48:56,734 truncating revision to first 12 chars 2017-01-07 08:48:56,735 Setting DEBUG logging. 2017-01-07 08:48:56,735 attempt 1/10 2017-01-07 08:48:56,735 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/58e5b3c7bdaf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-07 08:48:57,806 unpacking tar archive at: mozilla-aurora-58e5b3c7bdaf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.334550 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-07 08:48:57.999283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 08:48:57.999555) ========= script_repo_revision: 58e5b3c7bdaf6e60a50c7a59c7105a0eb5dd0c2d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 08:48:58.002927) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 08:48:58.003197) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 08:48:58.026797) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-01-07 08:48:58.027088) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RxFDWdNRDK/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.0R86a1HTzT/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:48:58 INFO - MultiFileLogger online at 20170107 08:48:58 in /builds/slave/test 08:48:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:48:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:48:58 INFO - {'append_to_log': False, 08:48:58 INFO - 'base_work_dir': '/builds/slave/test', 08:48:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:48:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:48:58 INFO - 'branch': 'Mozilla-Aurora', 08:48:58 INFO - 'buildbot_json_path': 'buildprops.json', 08:48:58 INFO - 'config_files': ('talos/mac_config.py',), 08:48:58 INFO - 'default_actions': ('clobber', 08:48:58 INFO - 'read-buildbot-config', 08:48:58 INFO - 'download-and-extract', 08:48:58 INFO - 'populate-webroot', 08:48:58 INFO - 'create-virtualenv', 08:48:58 INFO - 'install', 08:48:58 INFO - 'run-tests'), 08:48:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:48:58 INFO - 'download_minidump_stackwalk': True, 08:48:58 INFO - 'download_symbols': 'ondemand', 08:48:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:48:58 INFO - 'tooltool.py': '/tools/tooltool.py', 08:48:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:48:58 INFO - '/tools/misc-python/virtualenv.py')}, 08:48:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:48:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:48:58 INFO - 'installer_path': 'installer.exe', 08:48:58 INFO - 'log_level': 'info', 08:48:58 INFO - 'log_name': 'talos', 08:48:58 INFO - 'log_to_console': True, 08:48:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:48:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:48:58 INFO - 'opt_config_files': (), 08:48:58 INFO - 'pip_index': False, 08:48:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:48:58 INFO - 'cmd': ('bash', 08:48:58 INFO - '-c', 08:48:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:48:58 INFO - 'enabled': True, 08:48:58 INFO - 'halt_on_failure': False, 08:48:58 INFO - 'name': 'check_screen_resolution'},), 08:48:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:48:58 INFO - 'cmd': ('bash', 08:48:58 INFO - '-c', 08:48:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:48:58 INFO - 'enabled': True, 08:48:58 INFO - 'halt_on_failure': False, 08:48:58 INFO - 'name': 'check_screen_resolution'},), 08:48:58 INFO - 'run_cmd_checks_enabled': True, 08:48:58 INFO - 'sps_profile': False, 08:48:58 INFO - 'sps_profile_interval': 0, 08:48:58 INFO - 'suite': 'dromaeojs', 08:48:58 INFO - 'system_bits': '32', 08:48:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:48:58 INFO - 'title': 't-yosemite-r7-0190', 08:48:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:48:58 INFO - 'use_talos_json': True, 08:48:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:48:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:48:58 INFO - 'work_dir': 'build'} 08:48:58 INFO - [mozharness: 2017-01-07 16:48:58.238626Z] Running clobber step. 08:48:58 INFO - Running pre-action listener: _resource_record_pre_action 08:48:58 INFO - Running main action method: clobber 08:48:58 INFO - rmtree: /builds/slave/test/build 08:48:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:49:00 INFO - Running post-action listener: _resource_record_post_action 08:49:00 INFO - [mozharness: 2017-01-07 16:49:00.552575Z] Finished clobber step (success) 08:49:00 INFO - [mozharness: 2017-01-07 16:49:00.552669Z] Running read-buildbot-config step. 08:49:00 INFO - Running pre-action listener: _resource_record_pre_action 08:49:00 INFO - Running main action method: read_buildbot_config 08:49:00 INFO - Using buildbot properties: 08:49:00 INFO - { 08:49:00 INFO - "project": "", 08:49:00 INFO - "product": "firefox", 08:49:00 INFO - "script_repo_revision": "production", 08:49:00 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:49:00 INFO - "repository": "", 08:49:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:49:00 INFO - "buildid": "20170107063756", 08:49:00 INFO - "pgo_build": "False", 08:49:00 INFO - "basedir": "/builds/slave/test", 08:49:00 INFO - "buildnumber": 13, 08:49:00 INFO - "slavename": "t-yosemite-r7-0190", 08:49:00 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:49:00 INFO - "platform": "yosemite_r7", 08:49:00 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:49:00 INFO - "branch": "mozilla-aurora", 08:49:00 INFO - "repo_path": "releases/mozilla-aurora", 08:49:00 INFO - "revision": "58e5b3c7bdaf6e60a50c7a59c7105a0eb5dd0c2d", 08:49:00 INFO - "stage_platform": "macosx64", 08:49:00 INFO - "builduid": "7922d12289e54cae8367033373c24d57", 08:49:00 INFO - "slavebuilddir": "test" 08:49:00 INFO - } 08:49:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:49:00 INFO - Running post-action listener: _resource_record_post_action 08:49:00 INFO - [mozharness: 2017-01-07 16:49:00.556086Z] Finished read-buildbot-config step (success) 08:49:00 INFO - [mozharness: 2017-01-07 16:49:00.556170Z] Running download-and-extract step. 08:49:00 INFO - Running pre-action listener: _resource_record_pre_action 08:49:00 INFO - Running main action method: download_and_extract 08:49:00 INFO - mkdir: /builds/slave/test/build/tests 08:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:00 INFO - trying https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:49:00 INFO - Downloading https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:49:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 08:49:01 INFO - Downloaded 1199 bytes. 08:49:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:49:01 INFO - Using the following test package requirements: 08:49:01 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:49:01 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:49:01 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:49:01 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:49:01 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:49:01 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:49:01 INFO - u'jsshell-mac.zip'], 08:49:01 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:49:01 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:49:01 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:49:01 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:49:01 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:49:01 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:49:01 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:49:01 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:49:01 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:49:01 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:49:01 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:49:01 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:49:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:49:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:49:01 INFO - Fetch https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:49:02 INFO - Http code: 200 08:49:02 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 08:49:02 INFO - x-amz-cf-id: YJL191IcQ3_Y75SMlgHLwDBLHfD0svTA4ZdGei8a-9D1WZPWWAn_Yw== 08:49:02 INFO - x-amz-version-id: PdWluMzIkAey5fBssz4ZemiVrdkmFp.. 08:49:02 INFO - Expected file size: 16269568 08:49:02 INFO - Obtained file size: 16269568 08:49:09 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:49:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:49:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:49:09 INFO - Fetch https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:49:10 INFO - Http code: 200 08:49:10 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 08:49:10 INFO - x-amz-cf-id: IXrLI4EM1w13koBWHWns6tUkv4bpWZKP0FnkjPF27GQemsb097HpOA== 08:49:10 INFO - x-amz-version-id: PdWluMzIkAey5fBssz4ZemiVrdkmFp.. 08:49:10 INFO - Expected file size: 16269568 08:49:10 INFO - Obtained file size: 16269568 08:49:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:49:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:49:16 INFO - Fetch https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:49:17 INFO - Http code: 200 08:49:17 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 08:49:17 INFO - x-amz-cf-id: bLKcZtWdk6m3yB7wK1eBUWXQ1Kt4Wnl0aM_OG3KQM6iVknoiYXHZRA== 08:49:17 INFO - x-amz-version-id: BPH48p.UZo7AV.7fNJ5gQxua.xZeJXIo 08:49:18 INFO - Expected file size: 14409038 08:49:18 INFO - Obtained file size: 14409038 08:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:18 INFO - trying https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:49:18 INFO - Downloading https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 08:49:21 INFO - Downloaded 109864708 bytes. 08:49:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:49:21 INFO - mkdir: /builds/slave/test/properties 08:49:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:49:21 INFO - Writing to file /builds/slave/test/properties/build_url 08:49:21 INFO - Contents: 08:49:21 INFO - build_url:https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:49:21 INFO - Running post-action listener: _resource_record_post_action 08:49:21 INFO - Running post-action listener: set_extra_try_arguments 08:49:21 INFO - [mozharness: 2017-01-07 16:49:21.832780Z] Finished download-and-extract step (success) 08:49:21 INFO - [mozharness: 2017-01-07 16:49:21.832908Z] Running populate-webroot step. 08:49:21 INFO - Running pre-action listener: _resource_record_pre_action 08:49:21 INFO - Running main action method: populate_webroot 08:49:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:49:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:49:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:49:21 INFO - '--tppagecycles', 08:49:21 INFO - '7'], 08:49:21 INFO - 'tests': ['tsvgm']}}, 08:49:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:49:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:49:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:49:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:49:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:49:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:49:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:21 INFO - 'talos_options': ['--disable-e10s'], 08:49:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:21 INFO - 'talos_options': ['--disable-e10s'], 08:49:21 INFO - 'tests': ['damp', 'tps']}, 08:49:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:21 INFO - 'tests': ['damp', 'tps']}, 08:49:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:49:21 INFO - 'tests': ['dromaeo_dom']}, 08:49:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:49:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:49:21 INFO - 'tests': ['basic_compositor_video']}, 08:49:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:49:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:49:21 INFO - 'tests': ['a11yr', 08:49:21 INFO - 'ts_paint', 08:49:21 INFO - 'tpaint', 08:49:21 INFO - 'sessionrestore', 08:49:21 INFO - 'sessionrestore_no_auto_restore', 08:49:21 INFO - 'tabpaint']}, 08:49:21 INFO - 'other-e10s': {'tests': ['a11yr', 08:49:21 INFO - 'ts_paint', 08:49:21 INFO - 'tpaint', 08:49:21 INFO - 'sessionrestore', 08:49:21 INFO - 'sessionrestore_no_auto_restore', 08:49:21 INFO - 'tabpaint']}, 08:49:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:49:21 INFO - 'ts_paint', 08:49:21 INFO - 'tpaint', 08:49:21 INFO - 'sessionrestore', 08:49:21 INFO - 'sessionrestore_no_auto_restore', 08:49:21 INFO - 'tabpaint']}, 08:49:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:49:21 INFO - 'ts_paint', 08:49:21 INFO - 'tpaint', 08:49:21 INFO - 'sessionrestore', 08:49:21 INFO - 'sessionrestore_no_auto_restore', 08:49:21 INFO - 'tabpaint']}, 08:49:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:49:21 INFO - 'tests': ['a11yr', 08:49:21 INFO - 'ts_paint', 08:49:21 INFO - 'tpaint', 08:49:21 INFO - 'sessionrestore', 08:49:21 INFO - 'sessionrestore_no_auto_restore', 08:49:21 INFO - 'tabpaint']}, 08:49:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:49:21 INFO - 'tests': ['a11yr', 08:49:21 INFO - 'ts_paint', 08:49:21 INFO - 'tpaint', 08:49:21 INFO - 'sessionrestore', 08:49:21 INFO - 'sessionrestore_no_auto_restore', 08:49:21 INFO - 'tabpaint']}, 08:49:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:49:21 INFO - 'tests': ['tsvgx', 08:49:21 INFO - 'tsvgr_opacity', 08:49:21 INFO - 'tart', 08:49:21 INFO - 'tscrollx', 08:49:21 INFO - 'cart']}, 08:49:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:49:21 INFO - 'tsvgr_opacity', 08:49:21 INFO - 'tart', 08:49:21 INFO - 'tscrollx', 08:49:21 INFO - 'cart']}, 08:49:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:21 INFO - 'talos_options': ['--disable-e10s'], 08:49:21 INFO - 'tests': ['tp5o']}, 08:49:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:21 INFO - 'tests': ['tp5o']}, 08:49:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:21 INFO - 'talos_options': ['--disable-e10s', 08:49:21 INFO - '--xperf_path', 08:49:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:21 INFO - 'tests': ['tp5n']}, 08:49:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:21 INFO - 'talos_options': ['--xperf_path', 08:49:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:21 INFO - 'tests': ['tp5n']}}, 08:49:21 INFO - 'talos.zip': {'path': '', 08:49:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:49:21 INFO - Running post-action listener: _resource_record_post_action 08:49:21 INFO - [mozharness: 2017-01-07 16:49:21.851927Z] Finished populate-webroot step (success) 08:49:21 INFO - [mozharness: 2017-01-07 16:49:21.852057Z] Running create-virtualenv step. 08:49:21 INFO - Running pre-action listener: _resource_record_pre_action 08:49:21 INFO - Running main action method: create_virtualenv 08:49:21 INFO - Creating virtualenv /builds/slave/test/build/venv 08:49:21 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 08:49:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:49:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:49:21 INFO - Using real prefix '/tools/python27' 08:49:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:49:22 INFO - Installing distribute.............................................................................................................................................................................................done. 08:49:25 INFO - Installing pip.................done. 08:49:25 INFO - Return code: 0 08:49:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:49:25 INFO - Reading from file tmpfile_stdout 08:49:25 INFO - Output received: 08:49:25 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) 08:49:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:25 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 0x1093ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109375570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff24d58a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109213d30>, '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 0x109079db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920bb20>, '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.RxFDWdNRDK/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.0R86a1HTzT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:49:25 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 08:49:25 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 08:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFDWdNRDK/Render', 08:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:25 INFO - 'HOME': '/Users/cltbld', 08:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:25 INFO - 'LOGNAME': 'cltbld', 08:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:25 INFO - 'MOZ_NO_REMOTE': '1', 08:49:25 INFO - 'NO_EM_RESTART': '1', 08:49:25 INFO - 'PAGER': '/bin/cat', 08:49:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:25 INFO - 'PWD': '/builds/slave/test', 08:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:25 INFO - 'SHELL': '/bin/bash', 08:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R86a1HTzT/Listeners', 08:49:25 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:25 INFO - 'USER': 'cltbld', 08:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:25 INFO - 'XPC_FLAGS': '0x0', 08:49:25 INFO - 'XPC_SERVICE_NAME': '0', 08:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:26 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 08:49:26 INFO - Cleaning up... 08:49:26 INFO - Return code: 0 08:49:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:26 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 0x1093ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109375570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff24d58a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109213d30>, '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 0x109079db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920bb20>, '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.RxFDWdNRDK/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.0R86a1HTzT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:49:26 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 08:49:26 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 08:49:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFDWdNRDK/Render', 08:49:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:26 INFO - 'HOME': '/Users/cltbld', 08:49:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:26 INFO - 'LOGNAME': 'cltbld', 08:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:26 INFO - 'MOZ_NO_REMOTE': '1', 08:49:26 INFO - 'NO_EM_RESTART': '1', 08:49:26 INFO - 'PAGER': '/bin/cat', 08:49:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:26 INFO - 'PWD': '/builds/slave/test', 08:49:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:26 INFO - 'SHELL': '/bin/bash', 08:49:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R86a1HTzT/Listeners', 08:49:26 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:49:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:26 INFO - 'USER': 'cltbld', 08:49:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:26 INFO - 'XPC_FLAGS': '0x0', 08:49:26 INFO - 'XPC_SERVICE_NAME': '0', 08:49:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:26 INFO - Downloading/unpacking psutil>=3.1.1 08:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:49:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:31 INFO - Installing collected packages: psutil 08:49:31 INFO - Running setup.py install for psutil 08:49:31 INFO - building 'psutil._psutil_osx' extension 08:49:31 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 08:49:31 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 08:49:32 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 08:49:32 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 08:49:32 INFO - building 'psutil._psutil_posix' extension 08:49:32 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 08:49:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:49:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:49:32 INFO - ^ 08:49:32 INFO - 1 warning generated. 08:49:32 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 08:49:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:32 INFO - Successfully installed psutil 08:49:32 INFO - Cleaning up... 08:49:32 INFO - Return code: 0 08:49:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109375570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff24d58a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109213d30>, '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 0x109079db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920bb20>, '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.RxFDWdNRDK/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.0R86a1HTzT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:49:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:49:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFDWdNRDK/Render', 08:49:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:32 INFO - 'HOME': '/Users/cltbld', 08:49:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:32 INFO - 'LOGNAME': 'cltbld', 08:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:32 INFO - 'MOZ_NO_REMOTE': '1', 08:49:32 INFO - 'NO_EM_RESTART': '1', 08:49:32 INFO - 'PAGER': '/bin/cat', 08:49:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:32 INFO - 'PWD': '/builds/slave/test', 08:49:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:32 INFO - 'SHELL': '/bin/bash', 08:49:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R86a1HTzT/Listeners', 08:49:32 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:49:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:32 INFO - 'USER': 'cltbld', 08:49:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:32 INFO - 'XPC_FLAGS': '0x0', 08:49:32 INFO - 'XPC_SERVICE_NAME': '0', 08:49:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:49:32 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 08:49:32 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 08:49:32 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 08:49:32 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 08:49:32 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 08:49:32 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 08:49:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:49:35 INFO - Installing collected packages: mozsystemmonitor 08:49:35 INFO - Running setup.py install for mozsystemmonitor 08:49:35 INFO - Successfully installed mozsystemmonitor 08:49:35 INFO - Cleaning up... 08:49:35 INFO - Return code: 0 08:49:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:35 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 0x1093ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109375570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff24d58a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109213d30>, '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 0x109079db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920bb20>, '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.RxFDWdNRDK/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.0R86a1HTzT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:49:35 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 08:49:35 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 08:49:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFDWdNRDK/Render', 08:49:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:35 INFO - 'HOME': '/Users/cltbld', 08:49:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:35 INFO - 'LOGNAME': 'cltbld', 08:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:35 INFO - 'MOZ_NO_REMOTE': '1', 08:49:35 INFO - 'NO_EM_RESTART': '1', 08:49:35 INFO - 'PAGER': '/bin/cat', 08:49:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:35 INFO - 'PWD': '/builds/slave/test', 08:49:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:35 INFO - 'SHELL': '/bin/bash', 08:49:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R86a1HTzT/Listeners', 08:49:35 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:49:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:35 INFO - 'USER': 'cltbld', 08:49:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:35 INFO - 'XPC_FLAGS': '0x0', 08:49:35 INFO - 'XPC_SERVICE_NAME': '0', 08:49:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:35 INFO - Downloading/unpacking jsonschema==2.5.1 08:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:49:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:49:38 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 08:49:38 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 08:49:38 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 08:49:38 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 08:49:38 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 08:49:38 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 08:49:38 INFO - Downloading functools32-3.2.3-2.tar.gz 08:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:49:39 INFO - warning: no files found matching '*.txt' 08:49:39 INFO - no previously-included directories found matching 'build' 08:49:39 INFO - no previously-included directories found matching 'dist' 08:49:39 INFO - no previously-included directories found matching '.git*' 08:49:39 INFO - Installing collected packages: jsonschema, functools32 08:49:39 INFO - Running setup.py install for functools32 08:49:39 INFO - warning: no files found matching '*.txt' 08:49:39 INFO - no previously-included directories found matching 'build' 08:49:39 INFO - no previously-included directories found matching 'dist' 08:49:39 INFO - no previously-included directories found matching '.git*' 08:49:39 INFO - Successfully installed jsonschema functools32 08:49:39 INFO - Cleaning up... 08:49:39 INFO - Return code: 0 08:49:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:49:39 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')]} 08:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:39 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')]} 08:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:39 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 0x1093ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109375570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff24d58a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109213d30>, '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 0x109079db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920bb20>, '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.RxFDWdNRDK/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.0R86a1HTzT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:49:39 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 08:49:39 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 08:49:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFDWdNRDK/Render', 08:49:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:39 INFO - 'HOME': '/Users/cltbld', 08:49:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:39 INFO - 'LOGNAME': 'cltbld', 08:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:39 INFO - 'MOZ_NO_REMOTE': '1', 08:49:39 INFO - 'NO_EM_RESTART': '1', 08:49:39 INFO - 'PAGER': '/bin/cat', 08:49:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:39 INFO - 'PWD': '/builds/slave/test', 08:49:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:39 INFO - 'SHELL': '/bin/bash', 08:49:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R86a1HTzT/Listeners', 08:49:39 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:49:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:39 INFO - 'USER': 'cltbld', 08:49:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:39 INFO - 'XPC_FLAGS': '0x0', 08:49:39 INFO - 'XPC_SERVICE_NAME': '0', 08:49:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:49:39 INFO - Cleaning up... 08:49:39 INFO - Return code: 0 08:49:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:49:39 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')]} 08:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:39 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')]} 08:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:39 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 0x1093ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109375570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff24d58a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109213d30>, '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 0x109079db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920bb20>, '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.RxFDWdNRDK/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.0R86a1HTzT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:49:39 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 08:49:39 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 08:49:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFDWdNRDK/Render', 08:49:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:39 INFO - 'HOME': '/Users/cltbld', 08:49:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:39 INFO - 'LOGNAME': 'cltbld', 08:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:39 INFO - 'MOZ_NO_REMOTE': '1', 08:49:39 INFO - 'NO_EM_RESTART': '1', 08:49:39 INFO - 'PAGER': '/bin/cat', 08:49:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:39 INFO - 'PWD': '/builds/slave/test', 08:49:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:39 INFO - 'SHELL': '/bin/bash', 08:49:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R86a1HTzT/Listeners', 08:49:39 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:49:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:39 INFO - 'USER': 'cltbld', 08:49:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:39 INFO - 'XPC_FLAGS': '0x0', 08:49:39 INFO - 'XPC_SERVICE_NAME': '0', 08:49:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:39 INFO - Downloading/unpacking blobuploader==1.2.4 08:49:39 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 08:49:39 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 08:49:39 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 08:49:39 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 08:49:39 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 08:49:39 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 08:49:42 INFO - Downloading blobuploader-1.2.4.tar.gz 08:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:49:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:49:42 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 08:49:42 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 08:49:42 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 08:49:42 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 08:49:42 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 08:49:42 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 08:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:49:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:43 INFO - Downloading docopt-0.6.1.tar.gz 08:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:49:43 INFO - Installing collected packages: blobuploader, requests, docopt 08:49:43 INFO - Running setup.py install for blobuploader 08:49:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:49:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:49:44 INFO - Running setup.py install for requests 08:49:44 INFO - Running setup.py install for docopt 08:49:44 INFO - Successfully installed blobuploader requests docopt 08:49:44 INFO - Cleaning up... 08:49:44 INFO - Return code: 0 08:49:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:44 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 0x1093ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109375570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff24d58a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109213d30>, '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 0x109079db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920bb20>, '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.RxFDWdNRDK/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.0R86a1HTzT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:49:44 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 08:49:44 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 08:49:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFDWdNRDK/Render', 08:49:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:44 INFO - 'HOME': '/Users/cltbld', 08:49:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:44 INFO - 'LOGNAME': 'cltbld', 08:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:44 INFO - 'MOZ_NO_REMOTE': '1', 08:49:44 INFO - 'NO_EM_RESTART': '1', 08:49:44 INFO - 'PAGER': '/bin/cat', 08:49:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:44 INFO - 'PWD': '/builds/slave/test', 08:49:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:44 INFO - 'SHELL': '/bin/bash', 08:49:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R86a1HTzT/Listeners', 08:49:44 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:49:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:44 INFO - 'USER': 'cltbld', 08:49:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:44 INFO - 'XPC_FLAGS': '0x0', 08:49:44 INFO - 'XPC_SERVICE_NAME': '0', 08:49:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Md2yZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-QQ5a9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-psFzJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-RAlIBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-cfOySJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-ZbngBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-3OILXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-l0hQZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-E5Kx0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-UgOtYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-cWq2OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-p9p2ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-HsizZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-wEfzCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-na61Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-dBKOUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-25X5tS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:49:46 INFO - Running setup.py install for manifestparser 08:49:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:49:46 INFO - Running setup.py install for mozcrash 08:49:47 INFO - Running setup.py install for mozdebug 08:49:47 INFO - Running setup.py install for mozdevice 08:49:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:49:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:49:47 INFO - Running setup.py install for mozfile 08:49:47 INFO - Running setup.py install for mozhttpd 08:49:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:49:47 INFO - Running setup.py install for mozinfo 08:49:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:49:47 INFO - Running setup.py install for mozInstall 08:49:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:49:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:49:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:49:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:49:47 INFO - Running setup.py install for mozleak 08:49:48 INFO - Running setup.py install for mozlog 08:49:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Running setup.py install for moznetwork 08:49:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Running setup.py install for mozprocess 08:49:48 INFO - Running setup.py install for mozprofile 08:49:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Running setup.py install for mozrunner 08:49:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Running setup.py install for mozscreenshot 08:49:49 INFO - Running setup.py install for moztest 08:49:49 INFO - Running setup.py install for mozversion 08:49:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:49:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:49:49 INFO - Cleaning up... 08:49:49 INFO - Return code: 0 08:49:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:49 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 0x1093ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109375570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff24d58a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109213d30>, '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 0x109079db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920bb20>, '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.RxFDWdNRDK/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.0R86a1HTzT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:49:49 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 08:49:49 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 08:49:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFDWdNRDK/Render', 08:49:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:49 INFO - 'HOME': '/Users/cltbld', 08:49:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:49 INFO - 'LOGNAME': 'cltbld', 08:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:49 INFO - 'MOZ_NO_REMOTE': '1', 08:49:49 INFO - 'NO_EM_RESTART': '1', 08:49:49 INFO - 'PAGER': '/bin/cat', 08:49:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:49 INFO - 'PWD': '/builds/slave/test', 08:49:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:49 INFO - 'SHELL': '/bin/bash', 08:49:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R86a1HTzT/Listeners', 08:49:49 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:49:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:49 INFO - 'USER': 'cltbld', 08:49:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:49 INFO - 'XPC_FLAGS': '0x0', 08:49:49 INFO - 'XPC_SERVICE_NAME': '0', 08:49:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:49 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-xjQ3Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:49 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)) 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:49 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-hb0Jb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:49 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)) 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:49 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-LwJoCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:49 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)) 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:49 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-hQgYQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-GUD_Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:50 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)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-pwbaVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:50 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)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-2Y8l8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:50 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)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-nP3GvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:50 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)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Xkz_AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:50 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)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-vbUQW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:50 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)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-dwbGZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:50 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)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-7qtOSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-el2frc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:51 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)) 08:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:51 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-I4R7ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:51 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)) 08:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:51 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-lRJTl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:51 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)) 08:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:51 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-IgCApB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:51 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)) 08:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:51 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-jod9Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:51 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)) 08:49:51 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)) 08:49:51 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)) 08:49:51 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)) 08:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:49:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:49:51 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 08:49:51 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 08:49:51 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 08:49:51 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 08:49:51 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 08:49:51 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 08:49:53 INFO - Downloading blessings-1.6.tar.gz 08:49:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:49:54 INFO - Installing collected packages: blessings 08:49:54 INFO - Running setup.py install for blessings 08:49:54 INFO - Successfully installed blessings 08:49:54 INFO - Cleaning up... 08:49:54 INFO - Return code: 0 08:49:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:54 INFO - Reading from file tmpfile_stdout 08:49:54 INFO - Current package versions: 08:49:54 INFO - blessings == 1.6 08:49:54 INFO - blobuploader == 1.2.4 08:49:54 INFO - docopt == 0.6.1 08:49:54 INFO - functools32 == 3.2.3-2 08:49:54 INFO - jsonschema == 2.5.1 08:49:54 INFO - manifestparser == 1.1 08:49:54 INFO - mozInstall == 1.12 08:49:54 INFO - mozcrash == 1.0 08:49:54 INFO - mozdebug == 0.1 08:49:54 INFO - mozdevice == 0.48 08:49:54 INFO - mozfile == 1.2 08:49:54 INFO - mozhttpd == 0.7 08:49:54 INFO - mozinfo == 0.9 08:49:54 INFO - mozleak == 0.1 08:49:54 INFO - mozlog == 3.4 08:49:54 INFO - moznetwork == 0.27 08:49:54 INFO - mozprocess == 0.23 08:49:54 INFO - mozprofile == 0.28 08:49:54 INFO - mozrunner == 6.13 08:49:54 INFO - mozscreenshot == 0.1 08:49:54 INFO - mozsystemmonitor == 0.3 08:49:54 INFO - moztest == 0.8 08:49:54 INFO - mozversion == 1.4 08:49:54 INFO - psutil == 3.1.1 08:49:54 INFO - requests == 1.2.3 08:49:54 INFO - wsgiref == 0.1.2 08:49:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:54 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 0x1093ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109375570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff24d58a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109213d30>, '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 0x109079db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920bb20>, '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.RxFDWdNRDK/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.0R86a1HTzT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:49:54 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 08:49:54 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 08:49:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFDWdNRDK/Render', 08:49:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:54 INFO - 'HOME': '/Users/cltbld', 08:49:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:54 INFO - 'LOGNAME': 'cltbld', 08:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:54 INFO - 'MOZ_NO_REMOTE': '1', 08:49:54 INFO - 'NO_EM_RESTART': '1', 08:49:54 INFO - 'PAGER': '/bin/cat', 08:49:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:54 INFO - 'PWD': '/builds/slave/test', 08:49:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:54 INFO - 'SHELL': '/bin/bash', 08:49:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R86a1HTzT/Listeners', 08:49:54 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:49:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:54 INFO - 'USER': 'cltbld', 08:49:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:54 INFO - 'XPC_FLAGS': '0x0', 08:49:54 INFO - 'XPC_SERVICE_NAME': '0', 08:49:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:54 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)) 08:49:54 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)) 08:49:54 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)) 08:49:54 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)) 08:49:54 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)) 08:49:54 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)) 08:49:54 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)) 08:49:54 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)) 08:49:54 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)) 08:49:54 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)) 08:49:54 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)) 08:49:54 INFO - Cleaning up... 08:49:54 INFO - Return code: 0 08:49:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:54 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 0x1093ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109375570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff24d58a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109213d30>, '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 0x109079db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920bb20>, '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.RxFDWdNRDK/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.0R86a1HTzT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:49:54 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 08:49:54 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 08:49:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFDWdNRDK/Render', 08:49:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:54 INFO - 'HOME': '/Users/cltbld', 08:49:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:54 INFO - 'LOGNAME': 'cltbld', 08:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:54 INFO - 'MOZ_NO_REMOTE': '1', 08:49:54 INFO - 'NO_EM_RESTART': '1', 08:49:54 INFO - 'PAGER': '/bin/cat', 08:49:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:54 INFO - 'PWD': '/builds/slave/test', 08:49:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:54 INFO - 'SHELL': '/bin/bash', 08:49:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R86a1HTzT/Listeners', 08:49:54 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:49:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:54 INFO - 'USER': 'cltbld', 08:49:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:54 INFO - 'XPC_FLAGS': '0x0', 08:49:54 INFO - 'XPC_SERVICE_NAME': '0', 08:49:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:49:55 INFO - Cleaning up... 08:49:55 INFO - Return code: 0 08:49:55 INFO - Running post-action listener: _resource_record_post_action 08:49:55 INFO - Running post-action listener: _start_resource_monitoring 08:49:55 INFO - Starting resource monitoring. 08:49:55 INFO - [mozharness: 2017-01-07 16:49:55.220379Z] Finished create-virtualenv step (success) 08:49:55 INFO - [mozharness: 2017-01-07 16:49:55.221200Z] Running install step. 08:49:55 INFO - Running pre-action listener: _resource_record_pre_action 08:49:55 INFO - Running main action method: install 08:49:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:55 INFO - Reading from file tmpfile_stdout 08:49:55 INFO - Detecting whether we're running mozinstall >=1.0... 08:49:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:49:55 INFO - Reading from file tmpfile_stdout 08:49:55 INFO - Output received: 08:49:55 INFO - Usage: mozinstall [options] installer 08:49:55 INFO - Options: 08:49:55 INFO - -h, --help show this help message and exit 08:49:55 INFO - -d DEST, --destination=DEST 08:49:55 INFO - Directory to install application into. [default: 08:49:55 INFO - "/builds/slave/test"] 08:49:55 INFO - --app=APP Application being installed. [default: firefox] 08:49:55 INFO - mkdir: /builds/slave/test/build/application 08:49:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:50:26 INFO - Reading from file tmpfile_stdout 08:50:26 INFO - Output received: 08:50:26 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:50:26 INFO - Running post-action listener: _resource_record_post_action 08:50:26 INFO - [mozharness: 2017-01-07 16:50:26.684346Z] Finished install step (success) 08:50:26 INFO - [mozharness: 2017-01-07 16:50:26.684487Z] Running run-tests step. 08:50:26 INFO - Running pre-action listener: _resource_record_pre_action 08:50:26 INFO - Running main action method: run_tests 08:50:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:50:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:50:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:50:26 INFO - 2017-01-07 08:50:26.699 screenresolution[1636:9264] starting screenresolution argv=screenresolution get 08:50:26 INFO - 2017-01-07 08:50:26.701 screenresolution[1636:9264] Display 0: 1600x1200x32@60 08:50:26 INFO - 2017-01-07 08:50:26.707 screenresolution[1637:9266] starting screenresolution argv=screenresolution list 08:50:26 INFO - Available Modes on Display 0 08:50:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:50:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:50:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:50:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:50:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:50:26 INFO - Intel Iris: 08:50:26 INFO - Chipset Model: Intel Iris 08:50:26 INFO - Type: GPU 08:50:26 INFO - Bus: Built-In 08:50:26 INFO - VRAM (Dynamic, Max): 1536 MB 08:50:26 INFO - Vendor: Intel (0x8086) 08:50:26 INFO - Device ID: 0x0a2e 08:50:26 INFO - Revision ID: 0x0009 08:50:26 INFO - Displays: 08:50:26 INFO - Display: 08:50:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:50:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:50:26 INFO - Display Serial Number: 1600x1200 60 08:50:26 INFO - Main Display: Yes 08:50:26 INFO - Mirror: Off 08:50:26 INFO - Online: Yes 08:50:26 INFO - Rotation: Supported 08:50:26 INFO - Return code: 0 08:50:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:50:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:50:26 INFO - Python 2.7.3 08:50:26 INFO - Return code: 0 08:50:26 INFO - grabbing minidump binary from tooltool 08:50: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')]} 08:50:26 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 0x109213d30>, '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 0x109079db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:50:26 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 08:50:26 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 08:50:26 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 08:50:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:50:27 INFO - Return code: 0 08:50:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:50:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:50:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:50:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:50:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:50:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--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 08:50:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0190 --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 08:50:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFDWdNRDK/Render', 08:50:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:27 INFO - 'HOME': '/Users/cltbld', 08:50:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:27 INFO - 'LOGNAME': 'cltbld', 08:50:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:50:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:27 INFO - 'MOZ_NO_REMOTE': '1', 08:50:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:50:27 INFO - 'NO_EM_RESTART': '1', 08:50:27 INFO - 'PAGER': '/bin/cat', 08:50:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:27 INFO - 'PWD': '/builds/slave/test', 08:50:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:50:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:27 INFO - 'SHELL': '/bin/bash', 08:50:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R86a1HTzT/Listeners', 08:50:27 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:50:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:27 INFO - 'USER': 'cltbld', 08:50:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:27 INFO - 'XPC_FLAGS': '0x0', 08:50:27 INFO - 'XPC_SERVICE_NAME': '0', 08:50:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--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 08:50:27 INFO - mozversion application_buildid: 20170107063756 08:50:27 INFO - mozversion application_changeset: 58e5b3c7bdaf6e60a50c7a59c7105a0eb5dd0c2d 08:50:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:50:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:50:27 INFO - mozversion application_name: Firefox 08:50:27 INFO - mozversion application_remotingname: firefox-dev 08:50:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:50:27 INFO - mozversion application_vendor: Mozilla 08:50:27 INFO - mozversion application_version: 52.0a2 08:50:27 INFO - mozversion platform_buildid: 20170107063756 08:50:27 INFO - mozversion platform_changeset: 58e5b3c7bdaf6e60a50c7a59c7105a0eb5dd0c2d 08:50:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:50:27 INFO - mozversion platform_version: 52.0a2 08:50:27 INFO - using testdate: 1483807827 08:50:27 INFO - actual date: 1483807827 08:50:27 INFO - starting webserver on 'localhost:49243' 08:50:27 INFO - SUITE-START | Running 2 tests 08:50:27 INFO - TEST-START | dromaeo_css 08:50:27 INFO - operating with platform_type : mac_ 08:50:27 INFO - Initialising browser for dromaeo_css test... 08:50:27 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpW5W9V8/profile http://localhost:49243/getInfo.html) 08:50:30 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 08:50:30 INFO - PROCESS | 1647 | colorDepth:24 08:50:30 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 08:50:30 INFO - PROCESS | 1647 | __metrics 08:50:30 INFO - PROCESS | 1647 | 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" 08:50:30 INFO - PROCESS | 1647 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:50:31 INFO - TEST-INFO | 1647: exit 0 08:50:31 INFO - Browser initialized. 08:50:31 INFO - Running cycle 1/1 for dromaeo_css test... 08:50:31 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpW5W9V8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:43 INFO - PROCESS | 1650 | RSS: Main: 222781440 08:50:43 INFO - PROCESS | 1650 | 08:53:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 08:53:49 INFO - PROCESS | 1650 | RSS: Main: 343166976 08:53:49 INFO - PROCESS | 1650 | 08:56:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 08:56:52 INFO - PROCESS | 1650 | RSS: Main: 346357760 08:56:52 INFO - PROCESS | 1650 | 08:59:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 08:59:55 INFO - PROCESS | 1650 | RSS: Main: 326406144 08:59:55 INFO - PROCESS | 1650 | 09:02:57 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 09:02:58 INFO - PROCESS | 1650 | RSS: Main: 326815744 09:02:58 INFO - PROCESS | 1650 | 09:06:01 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 09:06:02 INFO - PROCESS | 1650 | RSS: Main: 311005184 09:06:02 INFO - PROCESS | 1650 | 09:09:05 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 09:09:06 INFO - PROCESS | 1650 | RSS: Main: 423120896 09:09:06 INFO - PROCESS | 1650 | 09:09:06 INFO - PROCESS | 1650 | __start_tp_report 09:09:06 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 09:09:06 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 09:09:06 INFO - PROCESS | 1650 | |i|pagename|runs| 09:09:06 INFO - PROCESS | 1650 | |0;dojo.html;3287.9342413151744;3288.490284005979;3314.1548905029213;3319.8008119512815;3344.331133773246;5628.662280263182;5688.118341657039;5695.458931401516;5700.515456186219;5720.742566584503;5608.9439105608935;5627.634203776752;5681.7727290908315;5699.344575373833;5722.141678748189;5143.3570803649545;5151.995360904625;5179.119549676564;5183.17069268917;5200.661956972804;5002.799888004475;5114.744262786864;5140.306058682087;5141.228815677641;5259.263703081571;5060.06388818068;5107.412647545524;5115.2071428928575;5136.126858434075;5148.150555158394;5098.056859481007;5116;5117.692938423706;5136.683532543837;5166.43169251382;5021.246812978083;5046.621503387224;5048.419431765357;5065.848024559269;5074.2895994560795;5573.777048918079;5598.776048958078;5618.15727640853;5695.060315048012;5722.885542289131;5110.97444512775;6141.631502109888;6143.723532441006;6162.352952939967;6208;6119.908201376983;6260.436560709558;6280.214973128359;6287.622742635456;6305.085762564402;5641.68970706611;5648.491635752761;5694.259746233046;5716.628419152742;5848.064309710511;6233.470155036873;6265.906011409833;6293.37066293367;6296.150019747367;6297.559170857996;6130.908036379458;6134.110553969738;6150.938490615126;6153.046277826944;6171.876562468726;6103.883205879379;6153.969230153821;6173;6175.59858609189;6217.6891155442045;6162.753489860445;6189.071639254058;6194.783182588678;6196.039613859859;6205.162303089115;6091.08633704939;6214.502839772807;6215.564910456224;6234.407731265523;6237.033259844731;4818.638602104857;4866.513348665176;4911.901761964812;4934.235193545006;4941.308216849572;4368.694191406635;4387.451568553931;4392.736435813861;4416.1609294233995;4461.687681862239;5564.304461942257;5593.692346920877;5662.433756624305;5673.205751194836;5683.374828768832;6173.536984726164;6229.501639868799;6233.688315584202;6238.033104868752;6238.937610623926;5586.776528938797;5620.971895140498;5621.0444224481935;5640.32316122068;5640.435956404327;5296.179092240709;5324.653897496651;5325.254464374991;5340.279062326536;5343.812966546152;5272.736363181903;6200.286966998853;6264.812055638338;6276.372362763778;6282.4974002079725;6203.2556093269095;6263.091851681572;6275.937240627535;6280.214973128359;6282.560220784501;6165.969170154121;6338;6338.0809782580345;6348.428641422294;6350.301466838551;4980.452150263396;6027.638341699512;6173.84565385869;6176.413240742122;6184.412480814315;6153.969230153821;6187.876242475215;6211.875762484635;6266.968665156645;6267.091271765477;6024.2407300174;6092.055731361646;6104.69476526163;6125.142480052886;6128.8774224516155;5824.737886795189;6011.827693599706;6102.023676211785;6119.143319935123;6120.8775824484155;5771.336296325809;5890.263717035371;5907;5928.051511758098;5993.910091348546;6076.058210977306;6077.726502307495;6090.969545152246;6100.542459315658;6104.633721976696;5892.292924849045;5893.882122357614;5915.911261330997;5919.467247947706;5938.257717785277 09:09:06 INFO - PROCESS | 1650 | |1;ext.html;472.263269299892;479.84405068352794;483.86209930169906;490.6835091366068;515.422726546268;29772.660230289635;38776;40165.59834401655;40211;41699.37450938238;34902.825485872534;40078;40491.19017619646;40947.795261023726;40955.59044409555;8114.553699546523;9110.544472776352;9277.907220927806;9290.628374864997;9305;8332.50004999699;8551.273141782956;10805.891941080607;11040;11057;11120.666380008572;11166.994970452657;11172.385518796464;11182.66452006441;11192.832107518394;8288.50268983863;11037.558497660084;11133.387663678495;11134.16493762963;11144.99999999996;8306.501609903426;8449.493030418194;8453.154684531559;8484.703035393732;10829.458527073693;37784.43323350152;39447.40828887569;39536.209275814326;39594;39756.807295781175;3219.871205151791;3235.854386552611;3268.215628249227;3502.1069627245142;3516.859325626972;28583.14250572486;29254.561181582292;29265.268368290752;29689.9608513701;29754.553681694793;3029.833359165245;3173.4129186100645;3188.8883889063773;3195.6484786673445;3220.146661134801;471310.7910144052;474202;474879;475249;475648;58769.412305876394;58886;59005.40994590085;59044.40955590475;59113;61255.693721531105;61394.079088813705;61399;61454;61487.07769383463;15323.923380383027;15735.291911863993;15806.130662813655;15806.9209653951;15810.288537015862;11041;11255.887441125647;12152.027837773134;12205.45075471606;12234.571789987307;16049;16395;16469.752953705705;16637.334506619598;16810.32758689663;6542.892126240093;6581.967090164519;6623.569467984566;6626.337366263431;6701.698423570951;831.4553967151404;935.2237642756496;935.8596210568332;972.5088830140875;985.8422652375585;28139.341885555157;28971.710282897322;29531.852340738158;29622.407551849272;29639.85180074129;1018.9061478661422;1028.1106842581262;1056.963006294776;1110.35044498969;1128.3624752015248;14733.705325893423;15038.699226015418;15243.923780381027;15416.46042388511;15428.845711542965;613739;614573;615298;618948;619332;56475.152872706945;56725.43274567201;56741.43258567444;56793.14810277849;56996;1210.195220178589;1250.9812352814897;1325.7282257137072;1361.0948719101884;1369.3153423288356;26218.557979310557;27446.86276568684;30045;30079.653437674784;30217.971376096062;48376;48941.02117957692;49138.50861491339;49186.26220606765;49196.50803491919;509802;511148;512610;513410;640400;24644.87677561601;25155.74844251534;25417.872910635328;25615;25729;44222.557774421846;44459.55540444684;44536.33195502135;44791.55208447874;44995.875103122686;36223;36767.81616091902;36882.07794805151;36934;37213;30507.54238686377;36537.634623654485;36866;36902;37264.627353726115;36621.450678239315;36645;36858.8157059213;37716.43425348567;39134.608653914234;26449.94200231969;31610.209744755644;33783.662163379035;33913.3217335647;33952.320953581286;24861.378465537782;25026.8737906791;25386.365340866625;25412.364690882136;25874.611880821427 09:09:06 INFO - PROCESS | 1650 | |2;jquery.html;335.19051490650094;347.79653902467055;361.9945700814487;379.7455704677865;398.9301872172369;14708.632284192901;14969.251537423126;15865.12741799202;20038.29865954692;20433;18879;19695.606087878234;20333.18667253308;20553.69169462459;20636.071376788044;5542.91685624716;5822.592418530705;5831.9416805831825;5834.620749651259;5847.970760146193;4097.528784189826;4852.539008794177;5690.63010904292;5726.513246374063;5727.484526392624;4321.438213032317;4358.476982762073;6019.097135429699;6357.046443033536;6366.872662546746;6116.418940200719;6299.811005669837;6388.64862432566;6403.167588213526;6404.167458230447;5557.888842223173;5569.359523654791;5569.916451253234;5575.2473416088715;5580.051391263495;24353.63469547958;24631.261062167985;24862.37844053913;25071.997120115175;25189.874050629813;2392.808575313971;2525.989604158333;2542.720300766914;2650.8144429889917;2879.9712002879915;14717.411303547846;15342.616434589114;15348.386064557404;16131.516054518383;16243.106629135393;1700.5918579540944;1835.5319393554691;1856.6750818606824;1877.4367689693038;1936.6223586400658;107308;122038;122822.77177228202;123718.2884513466;127299;9068.50123243228;9493;9883.159931405911;10240.283180177315;10576.312539684895;12114.970227530759;12508.874911250952;12602.684932876751;12603.117781755373;12629.43167557462;7781.844363112819;8088.555129467935;8099.149589293157;8185.222403871623;8194.590270486451;8397.664093436317;8438.831223375499;8494;8556.74329770108;8592.312614990786;3829.904252393657;3941.2708648900043;3949.921001579952;3975.582563830756;4005.5994400560294;1768.2750072470226;1891.924323027091;1926.7398901148447;1949.76602807664;1972.3925001124037;712.515489467157;719.0903507063568;731.5281643340016;828.883956246126;973.1436336024395;15738.842611573738;17316.653666926843;19854.907980061234;19947.401577952685;20549.69175462369;875.4047247871381;890.7060669978891;904.9095090490898;922.1331947968888;944.8677185194078;8851.867221991675;9548.37935534188;11096.00135987765;11297.378644174485;11402.258853174517;614624;623186;633730;653293;653642;139770;140237;140251;147647;148773;933.2580598424269;940.055244479294;959.8800149981253;963.1476143613093;964.3779762053576;18084.819151808315;18725.344612938483;19044.1430135647;19103.044847757836;19124.33064842724;57517.71241143768;58151.70924145352;58435;59427;59933.40066599278;74118.62940685262;76222;78431;81741;83928.16071839203;7622.594908975058;8073.39449541275;8165;8350.916490835258;8545.658173672984;9281.72154835356;12294.077944154045;12767.61697149087;13060.934695326463;13292.40184191733;10968.451577420938;10975.50610222526;11348.262362946381;11360.261582997078;11495.712607184887;11000.284981476178;11022.779544408906;11077.224594278323;11175.944120279346;11556.88443115558;11321.886781132083;11436.828447573127;11642;11816.231944923553;11855.34795586251;8116.350691944512;8187.426880118334;8341.24928756415;8387.83224335522;8400.327973761961;9736.659216927374;10779.461026948464;10942.17933654995;11208.775824483628;11393.487293071998 09:09:06 INFO - PROCESS | 1650 | |3;mootools.html;1438.9784153237704;1467.9192644404557;1518.5899807052097;1542.5989242796877;1570.7643853421991;8082.838343233139;8397.53813540255;8409.369297302705;8413.906192195022;8424.199701028409;7292.067602085452;7573.204813494573;7585.582792946386;7618.695252189919;7642.388608911274;2086.937391878246;2131.009080777438;2240.9663855042186;2312.6531020346915;2325.174563030117;2346.5658853112227;2348.9060437582475;2351.2123438647986;2351.7883390494853;2351.870647114408;2193.7148170737782;2222.822174226066;2225.3324002799095;2225.7869461143714;2227.888605569723;2162.8053475187153;2168.5012447137087;2282.9086836526517;2296.816254699628;2322.907083716649;2322.6516022596747;2327.4057270769576;2340.8010319122723;2350.189184731265;2350.6944097267246;8204.425690201688;8272.420930534865;8308.7091951782;8324.542150181738;8328.8334233315;5018.021485810268;5164.199549069863;5169.974150129263;5172.767225474862;5176.948230517684;3337.4326364518092;3483.303339332144;3490.2670439207795;3526.5239192708914;3573.8391772370305;1020.5458570935937;1059.3379138038727;1081.621432498627;1101.8732845722764;1108.5953626926193;9422;10731.248812583122;10830.67507974762;10866.61966831157;10876.673699789018;3682.613325600827;4544.568266014723;4616.469106052779;4617.746023968647;4726.26742854858;9263.722088337361;9266.119718626855;9283.535823208947;9303.162715355651;9317.487538185329;5149.871253218625;5150.356205474316;5150.407703114115;5153.5361817436615;5157.0975079361715;4594.494605593382;4656.092062047868;4710.717356958594;4727.763611819395;4731.503192164842;3500.1949551602765;3633.7456378053284;3647.179384638488;3710.7216958728204;3845.9807700961314;1166.1370585766472;1175.7707247086908;1182.7457096724074;1184.8815118488255;1190.4880901212562;834.0575150080371;847.9781862855244;861.7457849934284;898.5552151684827;902.2060586683676;5159.922601160985;5509.807156749494;5509.862253443615;5818.563607729353;6005.189299444606;848.8217474330336;939.3236869453982;946.597695979206;960.6541645007792;975.2685485885586;3647.7993710345654;3783.05423644089;3842.269968705937;3853.190829925747;3895.902602434962;9767;9922;10019.198464122852;10025.448600327052;10097.646582369729;9289.442633442015;9665.951670241604;9982.500874956224;9987.750306242257;9994.150497207673;7437.590932498656;7744.535327880345;7749.4575379724;7755.7673269802;7759.952406425174;4457.2645513489915;5471.425500322409;5478.233047373451;5619.522340600931;5641.915371269516;8908.198262156437;9006.63973441055;9152.313576481658;9183.862242066241;9272.768180795534;9253.722388328091;9320.161185493338;9335.533223338942;9418.199453046294;9445.52772361393;7160.57036577807;7230.783076507713;7623.313901748869;7779.688812447439;7784.377249819888;7499.737509187153;7597.810054748676;7707.959425477488;7720.8455830884195;7735.303822655988;6914.55055421396;6935.167779866247;6951.131108611424;7034.788956331318;7121.750738724119;6836.623985680636;6838.658067096725;6929.133858267716;7015.473839461959;7022.508424410242;6480.157579514633;6504.9674751625935;6591.274959754327;6596.043573681885;6600.438962688226;4668.229742092517;4800.679813051439;4809.687370320918;4853.150698627796;4969.925451118308;4801.399825021872;4806.303086052433;4862.635302352409;4914.655974081923;4979.103761322996 09:09:06 INFO - PROCESS | 1650 | |4;prototype.html;303.3947275186004;306.47133694377203;311.1552135950894;317.71247021445583;320.7289840085127;4724.480307166214;4915.35335662553;4994.602590756439;5188.766505507252;5249.658772179806;4358.978205108978;5011.498850114996;5111.463296353885;5111.974440127803;5185.170372740362;3566.8216589170565;4024.7182697211206;4033.1731994941115;4040.333344998079;4068.023674318157;3565.786052836825;3978.661813745835;4051.6758659307184;4056.8782936511952;4073.87778366648;3535.7524973251884;3728.9254214915686;3779.8488060477684;4004.679625629957;4019.778912159845;3572.6070132285427;3809.2381523695235;3996.680265578747;4001.97999010006;4007.4189242559664;2895.4788138135127;2937.2950491882007;2986.925326866824;3279.4097062528735;3554.129238336598;5042.571381432583;5097.923531147036;5115.2327150927285;5125.538701516882;5151.459096794858;3917.764934103963;4487.349334346534;4490.550944905516;4501.864944051684;4526.479454862667;4847.733374664392;4929.531694489017;5119.948800512022;5164.612654050961;5363.436839131874;3758.248350329945;3770.736803170941;3781.962180378216;3786.3941769316775;3794.31702293587;5122.436531981479;5424.728763561846;5734.311882574035;5766.298941812175;5812.8837423251725;3215.8070515769127;3513.8755598208327;3795.6963442925053;3803.8478460861256;3826.8277927492773;3380.7295416366633;3796.354619714655;3836.8081595920094;3889.7277190596387;3899.0642245861354;3828.5405751310022;4425.535318791545;4446.866594002185;4480.596746292849;4489.438820147481;4689.968206994456;5091.643584949018;5482.698451585201;5509.752061157257;5559.305086864142;1043.1081425381342;1141.869549146339;1180.6186761489078;1234.7160153164823;1242.2670374827246;836.5858899844616;845.9003295715668;858.5449711652834;860.0625318402846;860.1484530314943;4334.046509767846;4612.123696497655;4806.519348065235;4829.710217386968;4859.757012149449;5238.345206849144;5253.789848406097;5294.232336311214;5300.70846103468;5343.583950253186;4217.599328063829;4264.701470897007;4533.124178827121;4779.5220477951925;4826.490225083007;2636.986815065912;2640.4949178968186;2845.6158418613636;2851.329937464694;2862.298736809453;5533.833984980457;5533.897119094719;5549.528290095387;5550.666959982414;5551.805686800943;5445.863853403617;5480.054580623901;5492.231087647732;5513.892150348016;5601.8599535011135;4450.732956022649;5454.836354909438;5675.2054712340305;5899.168399168338;5939.406658971347;5284.603654725834;5400.108982017923;5703.173039909273;5763.827085187451;5805.506531944832;5398.811041613525;5693.829185124453;5703.743331550173;5712.914306285492;5738.0777439558215;4843.927341089957;4977.925331119964;5609.887802244014;5861.296644402529;5979.790707325223;3575.374309495776;3894.415837624379;3902.4390243902667;3902.4780335668543;3916.2754890345377;5053.797848086182;5398.946010539844;5489.866974378969;5716.571257155813;5769.480746732815;4947.3321101652255;5420;5454.563634909277;5458.699771512605;5604.971975140098;4433.512313645432;5513.614047016831;5557.861053473695;5569.637973531708;5599.468050535193;4617.74449013438;5290.365156181283;5331.493508116722;5402.51377376038;5454.236406903116;4992.750362481789;5221.242919776687;5494.972525137348;5554.3894369646205;5576.972115139399;4620.491745908014;4979.626528010486;5123.923141152811;5431.185322201702;5441.551301914075 09:09:06 INFO - PROCESS | 1650 | |5;yui.html;700.4186525184098;756.3684323589803;766.9194734552872;773.9342155916747;783.471156969046;14012.579622611313;14362.42550297988;15706.764398534016;16359;16407;14966.476173333935;15129;15140.86443516738;15154.393824247018;15164.317605707742;640.5996252342286;658.9868202635945;812.5571563497908;836.6820608168917;837.7863644770605;791.2917938445117;816.873384625384;822.7613991942329;828.1842385250524;828.8673812190051;872.8559787635032;875.4528419737663;876.7150676030284;879.7492714576347;885.3979294080023;679.5345188545862;868;869.8564736818449;869.9864657673802;871.5816408124073;526.4866754913967;549.2063967566868;645.0743183531647;654.8493846415304;657.4773055420952;14067.929660351632;14102.083364581269;14102.506412275521;14108.506202282872;14116.647083822883;12389.690257743538;12526.498940042387;12535;12563.811542826774;12724.300163491096;9135.720999060071;11317.83023254652;11331.490082946288;11969.64091077269;12197.45111469977;3649.799261040642;3661.212839239576;3674.4488326750934;3783.810809459516;3791.8672846450518;87704;90258;91417;92313.99999999933;92594.53702731444;10182.389056656624;10276;10358.378497290036;10358.689239322832;10397.58409663605;19773;19945.301914432926;19961.301354452815;19975.900120499304;20035.699464508045;7073.717051317993;7309.5248808827255;7371.226021267797;7522.097348318128;7572.167061623217;4108.1783643271465;4188.267053265667;4277.743335399886;4294.76378799169;4400.405945197422;3340;3387.3902697514686;3387.5765529308837;3403.676650718178;3457.27397246576;635.1520719839067;636.8885445047191;645.6094063091762;648.1768154443924;648.2577448821168;541;548.9313835770529;579.5942840012009;614.5790133758389;651.4169818012947;7032.648367581601;8741.300695944436;8818.382713210014;9100.499472529074;9597.760055998657;643.6910283064155;665.653859992801;674.6458109492555;680.421641604642;689.5207830557814;4165.708630324549;4444.799984000728;4452.621527170162;4475.686701930834;4533.342665313511;76587.61706191434;101650.47524287141;109759;112083;116768;95834;97164;99392;103239.45140822894;103890.4416433739;82408.17591824125;87245.56377218201;87792.42959844161;88274.11725882787;88848.5557572208;8344.66621335164;8581.8712719308;8808.163224493663;8880.289576833968;9022.14289642483;44006.339904900815;51046.23430648469;56324.15513767215;56605.15092273537;58399;40786.796066020666;53364;59171.704141479015;66811.66594166998;74096.25903740893;11161.55353785872;11727.706807329885;11782.410879456163;12122.212056216671;12492.937535312265;13951.302434878013;14143;14287.785683214968;14377.856221437652;15190.240487975778;12876.452572063778;13076.673083172996;13370.06409551322;13574.117682350616;13635;12557.748845022865;12767.93616031951;12894.871051289367;13273.336333183495;13897.888168946258;10298.742531436774;12153.210041347284;13092.803607945698;13118.606441806762;13554.796678049639;10534.315269507457;10763.3541987481;10899;11718.648440546796;12065.698357540781;11047.779044418905;11067.616547931508;11324.123485112765;11462;11602.709932251424 09:09:06 INFO - PROCESS | 1650 | __end_tp_report 09:09:06 INFO - PROCESS | 1650 | __start_cc_report 09:09:06 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1430 09:09:06 INFO - PROCESS | 1650 | __end_cc_report 09:09:06 INFO - PROCESS | 1650 | __startTimestamp1483808946021__endTimestamp 09:09:06 INFO - PROCESS | 1650 | 09:09:06 INFO - PROCESS | 1650 | ------- Summary: start ------- 09:09:06 INFO - PROCESS | 1650 | Number of tests: 6 09:09:06 INFO - PROCESS | 1650 | 09:09:06 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5687.45 Median:5893.88 stddev:653.42 (11.1%) stddev-sans-first:627.73 09:09:06 INFO - PROCESS | 1650 | Values: 3287.9 3288.5 3314.2 3319.8 3344.3 5628.7 5688.1 5695.5 5700.5 5720.7 5608.9 5627.6 5681.8 5699.3 5722.1 5143.4 5152.0 5179.1 5183.2 5200.7 5002.8 5114.7 5140.3 5141.2 5259.3 5060.1 5107.4 5115.2 5136.1 5148.2 5098.1 5116.0 5117.7 5136.7 5166.4 5021.2 5046.6 5048.4 5065.8 5074.3 5573.8 5598.8 5618.2 5695.1 5722.9 5111.0 6141.6 6143.7 6162.4 6208.0 6119.9 6260.4 6280.2 6287.6 6305.1 5641.7 5648.5 5694.3 5716.6 5848.1 6233.5 6265.9 6293.4 6296.2 6297.6 6130.9 6134.1 6150.9 6153.0 6171.9 6103.9 6154.0 6173.0 6175.6 6217.7 6162.8 6189.1 6194.8 6196.0 6205.2 6091.1 6214.5 6215.6 6234.4 6237.0 4818.6 4866.5 4911.9 4934.2 4941.3 4368.7 4387.5 4392.7 4416.2 4461.7 5564.3 5593.7 5662.4 5673.2 5683.4 6173.5 6229.5 6233.7 6238.0 6238.9 5586.8 5621.0 5621.0 5640.3 5640.4 5296.2 5324.7 5325.3 5340.3 5343.8 5272.7 6200.3 6264.8 6276.4 6282.5 6203.3 6263.1 6275.9 6280.2 6282.6 6166.0 6338.0 6338.1 6348.4 6350.3 4980.5 6027.6 6173.8 6176.4 6184.4 6154.0 6187.9 6211.9 6267.0 6267.1 6024.2 6092.1 6104.7 6125.1 6128.9 5824.7 6011.8 6102.0 6119.1 6120.9 5771.3 5890.3 5907.0 5928.1 5993.9 6076.1 6077.7 6091.0 6100.5 6104.6 5892.3 5893.9 5915.9 5919.5 5938.3 09:09:06 INFO - PROCESS | 1650 | 09:09:06 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:67247.71 Median:36813.32 stddev:146022.10 (396.7%) stddev-sans-first:146345.66 09:09:06 INFO - PROCESS | 1650 | Values: 472.3 479.8 483.9 490.7 515.4 29772.7 38776.0 40165.6 40211.0 41699.4 34902.8 40078.0 40491.2 40947.8 40955.6 8114.6 9110.5 9277.9 9290.6 9305.0 8332.5 8551.3 10805.9 11040.0 11057.0 11120.7 11167.0 11172.4 11182.7 11192.8 8288.5 11037.6 11133.4 11134.2 11145.0 8306.5 8449.5 8453.2 8484.7 10829.5 37784.4 39447.4 39536.2 39594.0 39756.8 3219.9 3235.9 3268.2 3502.1 3516.9 28583.1 29254.6 29265.3 29690.0 29754.6 3029.8 3173.4 3188.9 3195.6 3220.1 471310.8 474202.0 474879.0 475249.0 475648.0 58769.4 58886.0 59005.4 59044.4 59113.0 61255.7 61394.1 61399.0 61454.0 61487.1 15323.9 15735.3 15806.1 15806.9 15810.3 11041.0 11255.9 12152.0 12205.5 12234.6 16049.0 16395.0 16469.8 16637.3 16810.3 6542.9 6582.0 6623.6 6626.3 6701.7 831.5 935.2 935.9 972.5 985.8 28139.3 28971.7 29531.9 29622.4 29639.9 1018.9 1028.1 1057.0 1110.4 1128.4 14733.7 15038.7 15243.9 15416.5 15428.8 613739.0 614573.0 615298.0 618948.0 619332.0 56475.2 56725.4 56741.4 56793.1 56996.0 1210.2 1251.0 1325.7 1361.1 1369.3 26218.6 27446.9 30045.0 30079.7 30218.0 48376.0 48941.0 49138.5 49186.3 49196.5 509802.0 511148.0 512610.0 513410.0 640400.0 24644.9 25155.7 25417.9 25615.0 25729.0 44222.6 44459.6 44536.3 44791.6 44995.9 36223.0 36767.8 36882.1 36934.0 37213.0 30507.5 36537.6 36866.0 36902.0 37264.6 36621.5 36645.0 36858.8 37716.4 39134.6 26449.9 31610.2 33783.7 33913.3 33952.3 24861.4 25026.9 25386.4 25412.4 25874.6 09:09:06 INFO - PROCESS | 1650 | 09:09:06 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:36576.92 Median:370.87 stddev:106334.02 (28671.5%) stddev-sans-first:106597.49 09:09:06 INFO - PROCESS | 1650 | Values: 335.2 347.8 362.0 379.7 398.9 14708.6 14969.3 15865.1 20038.3 20433.0 18879.0 19695.6 20333.2 20553.7 20636.1 5542.9 5822.6 5831.9 5834.6 5848.0 4097.5 4852.5 5690.6 5726.5 5727.5 4321.4 4358.5 6019.1 6357.0 6366.9 6116.4 6299.8 6388.6 6403.2 6404.2 5557.9 5569.4 5569.9 5575.2 5580.1 24353.6 24631.3 24862.4 25072.0 25189.9 2392.8 2526.0 2542.7 2650.8 2880.0 14717.4 15342.6 15348.4 16131.5 16243.1 1700.6 1835.5 1856.7 1877.4 1936.6 107308.0 122038.0 122822.8 123718.3 127299.0 9068.5 9493.0 9883.2 10240.3 10576.3 12115.0 12508.9 12602.7 12603.1 12629.4 7781.8 8088.6 8099.1 8185.2 8194.6 8397.7 8438.8 8494.0 8556.7 8592.3 3829.9 3941.3 3949.9 3975.6 4005.6 1768.3 1891.9 1926.7 1949.8 1972.4 712.5 719.1 731.5 828.9 973.1 15738.8 17316.7 19854.9 19947.4 20549.7 875.4 890.7 904.9 922.1 944.9 8851.9 9548.4 11096.0 11297.4 11402.3 614624.0 623186.0 633730.0 653293.0 653642.0 139770.0 140237.0 140251.0 147647.0 148773.0 933.3 940.1 959.9 963.1 964.4 18084.8 18725.3 19044.1 19103.0 19124.3 57517.7 58151.7 58435.0 59427.0 59933.4 74118.6 76222.0 78431.0 81741.0 83928.2 7622.6 8073.4 8165.0 8350.9 8545.7 9281.7 12294.1 12767.6 13060.9 13292.4 10968.5 10975.5 11348.3 11360.3 11495.7 11000.3 11022.8 11077.2 11175.9 11556.9 11321.9 11436.8 11642.0 11816.2 11855.3 8116.4 8187.4 8341.2 8387.8 8400.3 9736.7 10779.5 10942.2 11208.8 11393.5 09:09:06 INFO - PROCESS | 1650 | 09:09:06 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5374.57 Median:5167.09 stddev:2928.91 (56.7%) stddev-sans-first:2922.19 09:09:06 INFO - PROCESS | 1650 | Values: 1439.0 1467.9 1518.6 1542.6 1570.8 8082.8 8397.5 8409.4 8413.9 8424.2 7292.1 7573.2 7585.6 7618.7 7642.4 2086.9 2131.0 2241.0 2312.7 2325.2 2346.6 2348.9 2351.2 2351.8 2351.9 2193.7 2222.8 2225.3 2225.8 2227.9 2162.8 2168.5 2282.9 2296.8 2322.9 2322.7 2327.4 2340.8 2350.2 2350.7 8204.4 8272.4 8308.7 8324.5 8328.8 5018.0 5164.2 5170.0 5172.8 5176.9 3337.4 3483.3 3490.3 3526.5 3573.8 1020.5 1059.3 1081.6 1101.9 1108.6 9422.0 10731.2 10830.7 10866.6 10876.7 3682.6 4544.6 4616.5 4617.7 4726.3 9263.7 9266.1 9283.5 9303.2 9317.5 5149.9 5150.4 5150.4 5153.5 5157.1 4594.5 4656.1 4710.7 4727.8 4731.5 3500.2 3633.7 3647.2 3710.7 3846.0 1166.1 1175.8 1182.7 1184.9 1190.5 834.1 848.0 861.7 898.6 902.2 5159.9 5509.8 5509.9 5818.6 6005.2 848.8 939.3 946.6 960.7 975.3 3647.8 3783.1 3842.3 3853.2 3895.9 9767.0 9922.0 10019.2 10025.4 10097.6 9289.4 9666.0 9982.5 9987.8 9994.2 7437.6 7744.5 7749.5 7755.8 7760.0 4457.3 5471.4 5478.2 5619.5 5641.9 8908.2 9006.6 9152.3 9183.9 9272.8 9253.7 9320.2 9335.5 9418.2 9445.5 7160.6 7230.8 7623.3 7779.7 7784.4 7499.7 7597.8 7708.0 7720.8 7735.3 6914.6 6935.2 6951.1 7034.8 7121.8 6836.6 6838.7 6929.1 7015.5 7022.5 6480.2 6505.0 6591.3 6596.0 6600.4 4668.2 4800.7 4809.7 4853.2 4969.9 4801.4 4806.3 4862.6 4914.7 4979.1 09:09:06 INFO - PROCESS | 1650 | 09:09:06 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4393.76 Median:4938.43 stddev:1361.62 (27.6%) stddev-sans-first:1330.38 09:09:06 INFO - PROCESS | 1650 | Values: 303.4 306.5 311.2 317.7 320.7 4724.5 4915.4 4994.6 5188.8 5249.7 4359.0 5011.5 5111.5 5112.0 5185.2 3566.8 4024.7 4033.2 4040.3 4068.0 3565.8 3978.7 4051.7 4056.9 4073.9 3535.8 3728.9 3779.8 4004.7 4019.8 3572.6 3809.2 3996.7 4002.0 4007.4 2895.5 2937.3 2986.9 3279.4 3554.1 5042.6 5097.9 5115.2 5125.5 5151.5 3917.8 4487.3 4490.6 4501.9 4526.5 4847.7 4929.5 5119.9 5164.6 5363.4 3758.2 3770.7 3782.0 3786.4 3794.3 5122.4 5424.7 5734.3 5766.3 5812.9 3215.8 3513.9 3795.7 3803.8 3826.8 3380.7 3796.4 3836.8 3889.7 3899.1 3828.5 4425.5 4446.9 4480.6 4489.4 4690.0 5091.6 5482.7 5509.8 5559.3 1043.1 1141.9 1180.6 1234.7 1242.3 836.6 845.9 858.5 860.1 860.1 4334.0 4612.1 4806.5 4829.7 4859.8 5238.3 5253.8 5294.2 5300.7 5343.6 4217.6 4264.7 4533.1 4779.5 4826.5 2637.0 2640.5 2845.6 2851.3 2862.3 5533.8 5533.9 5549.5 5550.7 5551.8 5445.9 5480.1 5492.2 5513.9 5601.9 4450.7 5454.8 5675.2 5899.2 5939.4 5284.6 5400.1 5703.2 5763.8 5805.5 5398.8 5693.8 5703.7 5712.9 5738.1 4843.9 4977.9 5609.9 5861.3 5979.8 3575.4 3894.4 3902.4 3902.5 3916.3 5053.8 5398.9 5489.9 5716.6 5769.5 4947.3 5420.0 5454.6 5458.7 5605.0 4433.5 5513.6 5557.9 5569.6 5599.5 4617.7 5290.4 5331.5 5402.5 5454.2 4992.8 5221.2 5495.0 5554.4 5577.0 4620.5 4979.6 5123.9 5431.2 5441.6 09:09:06 INFO - PROCESS | 1650 | 09:09:06 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:20177.52 Median:4347.58 stddev:29583.72 (680.5%) stddev-sans-first:29630.57 09:09:06 INFO - PROCESS | 1650 | Values: 700.4 756.4 766.9 773.9 783.5 14012.6 14362.4 15706.8 16359.0 16407.0 14966.5 15129.0 15140.9 15154.4 15164.3 640.6 659.0 812.6 836.7 837.8 791.3 816.9 822.8 828.2 828.9 872.9 875.5 876.7 879.7 885.4 679.5 868.0 869.9 870.0 871.6 526.5 549.2 645.1 654.8 657.5 14067.9 14102.1 14102.5 14108.5 14116.6 12389.7 12526.5 12535.0 12563.8 12724.3 9135.7 11317.8 11331.5 11969.6 12197.5 3649.8 3661.2 3674.4 3783.8 3791.9 87704.0 90258.0 91417.0 92314.0 92594.5 10182.4 10276.0 10358.4 10358.7 10397.6 19773.0 19945.3 19961.3 19975.9 20035.7 7073.7 7309.5 7371.2 7522.1 7572.2 4108.2 4188.3 4277.7 4294.8 4400.4 3340.0 3387.4 3387.6 3403.7 3457.3 635.2 636.9 645.6 648.2 648.3 541.0 548.9 579.6 614.6 651.4 7032.6 8741.3 8818.4 9100.5 9597.8 643.7 665.7 674.6 680.4 689.5 4165.7 4444.8 4452.6 4475.7 4533.3 76587.6 101650.5 109759.0 112083.0 116768.0 95834.0 97164.0 99392.0 103239.5 103890.4 82408.2 87245.6 87792.4 88274.1 88848.6 8344.7 8581.9 8808.2 8880.3 9022.1 44006.3 51046.2 56324.2 56605.2 58399.0 40786.8 53364.0 59171.7 66811.7 74096.3 11161.6 11727.7 11782.4 12122.2 12492.9 13951.3 14143.0 14287.8 14377.9 15190.2 12876.5 13076.7 13370.1 13574.1 13635.0 12557.7 12767.9 12894.9 13273.3 13897.9 10298.7 12153.2 13092.8 13118.6 13554.8 10534.3 10763.4 10899.0 11718.6 12065.7 11047.8 11067.6 11324.1 11462.0 11602.7 09:09:06 INFO - PROCESS | 1650 | -------- Summary: end -------- 09:09:06 INFO - PROCESS | 1650 | 09:09:06 INFO - TEST-INFO | 1650: exit 0 09:09:06 INFO - TEST-OK | dromaeo_css | took 1119392ms 09:09:06 INFO - TEST-START | kraken 09:09:06 INFO - operating with platform_type : mac_ 09:09:06 INFO - Initialising browser for kraken test... 09:09:06 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpUk64gH/profile http://localhost:49243/getInfo.html) 09:09:09 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 09:09:09 INFO - PROCESS | 1657 | colorDepth:24 09:09:09 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 09:09:09 INFO - PROCESS | 1657 | __metrics 09:09:09 INFO - PROCESS | 1657 | 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" 09:09:09 INFO - PROCESS | 1657 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:09:10 INFO - TEST-INFO | 1657: exit 0 09:09:10 INFO - Browser initialized. 09:09:10 INFO - Running cycle 1/1 for kraken test... 09:09:10 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpUk64gH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:22 INFO - PROCESS | 1658 | RSS: Main: 222728192 09:09:22 INFO - PROCESS | 1658 | 09:09:25 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 09:09:26 INFO - PROCESS | 1658 | RSS: Main: 272957440 09:09:26 INFO - PROCESS | 1658 | 09:09:28 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 09:09:29 INFO - PROCESS | 1658 | RSS: Main: 284532736 09:09:29 INFO - PROCESS | 1658 | 09:09:32 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 09:09:33 INFO - PROCESS | 1658 | RSS: Main: 383090688 09:09:33 INFO - PROCESS | 1658 | 09:09:35 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 09:09:35 INFO - PROCESS | 1658 | RSS: Main: 282402816 09:09:35 INFO - PROCESS | 1658 | 09:09:37 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:38 INFO - PROCESS | 1658 | RSS: Main: 284758016 09:09:38 INFO - PROCESS | 1658 | 09:09:41 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 09:09:41 INFO - PROCESS | 1658 | RSS: Main: 326397952 09:09:41 INFO - PROCESS | 1658 | 09:09:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 09:09:45 INFO - PROCESS | 1658 | RSS: Main: 326148096 09:09:45 INFO - PROCESS | 1658 | 09:09:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 09:09:48 INFO - PROCESS | 1658 | RSS: Main: 322674688 09:09:48 INFO - PROCESS | 1658 | 09:09:50 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:51 INFO - PROCESS | 1658 | RSS: Main: 299311104 09:09:51 INFO - PROCESS | 1658 | 09:09:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:53 INFO - PROCESS | 1658 | RSS: Main: 300158976 09:09:53 INFO - PROCESS | 1658 | 09:09:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:56 INFO - PROCESS | 1658 | RSS: Main: 302735360 09:09:56 INFO - PROCESS | 1658 | 09:09:59 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:10:00 INFO - PROCESS | 1658 | RSS: Main: 317583360 09:10:00 INFO - PROCESS | 1658 | 09:10:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:10:03 INFO - PROCESS | 1658 | RSS: Main: 310984704 09:10:03 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 09:10:05 INFO - PROCESS | 1658 | RSS: Main: 354525184 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | __start_tp_report 09:10:05 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 09:10:05 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 09:10:05 INFO - PROCESS | 1658 | |i|pagename|runs| 09:10:05 INFO - PROCESS | 1658 | |0;ai-astar;116;114;116;113;114;115;119;166;123;112 09:10:05 INFO - PROCESS | 1658 | |1;audio-beat-detection;145;109;113;144;112;118;137;137;155;110 09:10:05 INFO - PROCESS | 1658 | |2;audio-dft;185;186;184;183;184;182;184;182;185;182 09:10:05 INFO - PROCESS | 1658 | |3;audio-fft;83;77;81;114;63;63;58;58;84;59 09:10:05 INFO - PROCESS | 1658 | |4;audio-oscillator;84;69;93;70;68;69;88;67;69;94 09:10:05 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;88;84;88;85;88;85;90;88;87;84 09:10:05 INFO - PROCESS | 1658 | |6;imaging-darkroom;96;96;96;96;96;97;97;95;96;97 09:10:05 INFO - PROCESS | 1658 | |7;imaging-desaturate;82;82;93;131;109;85;86;127;126;128 09:10:05 INFO - PROCESS | 1658 | |8;json-parse-financial;54;53;53;53;57;58;59;59;57;58 09:10:05 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;60;72;67;75;74;68;69;69;69;69 09:10:05 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;84;84;83;84;81;83;83;83;83;82 09:10:05 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;139;144;152;151;134;143;145;143;185;145 09:10:05 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;163;166;164;163;165;163;164;163;163;161 09:10:05 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;62;65;85;82;85;84;84;80;66;66 09:10:05 INFO - PROCESS | 1658 | __end_tp_report 09:10:05 INFO - PROCESS | 1658 | __start_cc_report 09:10:05 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2041 09:10:05 INFO - PROCESS | 1658 | __end_cc_report 09:10:05 INFO - PROCESS | 1658 | __startTimestamp1483809005604__endTimestamp 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | ------- Summary: start ------- 09:10:05 INFO - PROCESS | 1658 | Number of tests: 14 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:120.80 Median:116.00 stddev:16.20 (14.0%) stddev-sans-first:17.09 09:10:05 INFO - PROCESS | 1658 | Values: 116.0 114.0 116.0 113.0 114.0 115.0 119.0 166.0 123.0 112.0 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:137.00 stddev:17.33 (12.6%) stddev-sans-first:17.25 09:10:05 INFO - PROCESS | 1658 | Values: 145.0 109.0 113.0 144.0 112.0 118.0 137.0 137.0 155.0 110.0 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.42 (0.8%) stddev-sans-first:1.42 09:10:05 INFO - PROCESS | 1658 | Values: 185.0 186.0 184.0 183.0 184.0 182.0 184.0 182.0 185.0 182.0 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:74.00 Median:70.00 stddev:17.69 (25.3%) stddev-sans-first:18.47 09:10:05 INFO - PROCESS | 1658 | Values: 83.0 77.0 81.0 114.0 63.0 63.0 58.0 58.0 84.0 59.0 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:77.00 stddev:11.24 (14.6%) stddev-sans-first:11.64 09:10:05 INFO - PROCESS | 1658 | Values: 84.0 69.0 93.0 70.0 68.0 69.0 88.0 67.0 69.0 94.0 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:88.00 stddev:2.06 (2.3%) stddev-sans-first:2.13 09:10:05 INFO - PROCESS | 1658 | Values: 88.0 84.0 88.0 85.0 88.0 85.0 90.0 88.0 87.0 84.0 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:10:05 INFO - PROCESS | 1658 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 97.0 95.0 96.0 97.0 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:104.90 Median:82.00 stddev:21.37 (26.1%) stddev-sans-first:20.99 09:10:05 INFO - PROCESS | 1658 | Values: 82.0 82.0 93.0 131.0 109.0 85.0 86.0 127.0 126.0 128.0 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:57.50 stddev:2.56 (4.4%) stddev-sans-first:2.60 09:10:05 INFO - PROCESS | 1658 | Values: 54.0 53.0 53.0 53.0 57.0 58.0 59.0 59.0 57.0 58.0 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:4.16 (6.0%) stddev-sans-first:2.77 09:10:05 INFO - PROCESS | 1658 | Values: 60.0 72.0 67.0 75.0 74.0 68.0 69.0 69.0 69.0 69.0 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:0.94 (1.1%) stddev-sans-first:0.93 09:10:05 INFO - PROCESS | 1658 | Values: 84.0 84.0 83.0 84.0 81.0 83.0 83.0 83.0 83.0 82.0 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:145.00 stddev:13.96 (9.6%) stddev-sans-first:14.42 09:10:05 INFO - PROCESS | 1658 | Values: 139.0 144.0 152.0 151.0 134.0 143.0 145.0 143.0 185.0 145.0 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:163.50 stddev:1.35 (0.8%) stddev-sans-first:1.42 09:10:05 INFO - PROCESS | 1658 | Values: 163.0 166.0 164.0 163.0 165.0 163.0 164.0 163.0 163.0 161.0 09:10:05 INFO - PROCESS | 1658 | 09:10:05 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:83.00 stddev:9.77 (11.8%) stddev-sans-first:8.97 09:10:05 INFO - PROCESS | 1658 | Values: 62.0 65.0 85.0 82.0 85.0 84.0 84.0 80.0 66.0 66.0 09:10:05 INFO - PROCESS | 1658 | -------- Summary: end -------- 09:10:05 INFO - PROCESS | 1658 | 09:10:06 INFO - TEST-INFO | 1658: exit 0 09:10:06 INFO - TEST-OK | kraken | took 60106ms 09:10:06 INFO - SUITE-END | took 1179s 09:10:07 INFO - Completed test suite (00:19:39) 09:10:07 INFO - javascript benchmark 09:10:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3287.9342413151744, 3288.490284005979, 3314.1548905029213, 3319.8008119512815, 3344.331133773246, 5628.662280263182, 5688.118341657039, 5695.458931401516, 5700.515456186219, 5720.742566584503, 5608.9439105608935, 5627.634203776752, 5681.7727290908315, 5699.344575373833, 5722.141678748189, 5143.3570803649545, 5151.995360904625, 5179.119549676564, 5183.17069268917, 5200.661956972804, 5002.799888004475, 5114.744262786864, 5140.306058682087, 5141.228815677641, 5259.263703081571, 5060.06388818068, 5107.412647545524, 5115.2071428928575, 5136.126858434075, 5148.150555158394, 5098.056859481007, 5116.0, 5117.692938423706, 5136.683532543837, 5166.43169251382, 5021.246812978083, 5046.621503387224, 5048.419431765357, 5065.848024559269, 5074.2895994560795, 5573.777048918079, 5598.776048958078, 5618.15727640853, 5695.060315048012, 5722.885542289131, 5110.97444512775, 6141.631502109888, 6143.723532441006, 6162.352952939967, 6208.0, 6119.908201376983, 6260.436560709558, 6280.214973128359, 6287.622742635456, 6305.085762564402, 5641.68970706611, 5648.491635752761, 5694.259746233046, 5716.628419152742, 5848.064309710511, 6233.470155036873, 6265.906011409833, 6293.37066293367, 6296.150019747367, 6297.559170857996, 6130.908036379458, 6134.110553969738, 6150.938490615126, 6153.046277826944, 6171.876562468726, 6103.883205879379, 6153.969230153821, 6173.0, 6175.59858609189, 6217.6891155442045, 6162.753489860445, 6189.071639254058, 6194.783182588678, 6196.039613859859, 6205.162303089115, 6091.08633704939, 6214.502839772807, 6215.564910456224, 6234.407731265523, 6237.033259844731, 4818.638602104857, 4866.513348665176, 4911.901761964812, 4934.235193545006, 4941.308216849572, 4368.694191406635, 4387.451568553931, 4392.736435813861, 4416.1609294233995, 4461.687681862239, 5564.304461942257, 5593.692346920877, 5662.433756624305, 5673.205751194836, 5683.374828768832, 6173.536984726164, 6229.501639868799, 6233.688315584202, 6238.033104868752, 6238.937610623926, 5586.776528938797, 5620.971895140498, 5621.0444224481935, 5640.32316122068, 5640.435956404327, 5296.179092240709, 5324.653897496651, 5325.254464374991, 5340.279062326536, 5343.812966546152, 5272.736363181903, 6200.286966998853, 6264.812055638338, 6276.372362763778, 6282.4974002079725, 6203.2556093269095, 6263.091851681572, 6275.937240627535, 6280.214973128359, 6282.560220784501, 6165.969170154121, 6338.0, 6338.0809782580345, 6348.428641422294, 6350.301466838551, 4980.452150263396, 6027.638341699512, 6173.84565385869, 6176.413240742122, 6184.412480814315, 6153.969230153821, 6187.876242475215, 6211.875762484635, 6266.968665156645, 6267.091271765477, 6024.2407300174, 6092.055731361646, 6104.69476526163, 6125.142480052886, 6128.8774224516155, 5824.737886795189, 6011.827693599706, 6102.023676211785, 6119.143319935123, 6120.8775824484155, 5771.336296325809, 5890.263717035371, 5907.0, 5928.051511758098, 5993.910091348546, 6076.058210977306, 6077.726502307495, 6090.969545152246, 6100.542459315658, 6104.633721976696, 5892.292924849045, 5893.882122357614, 5915.911261330997, 5919.467247947706, 5938.257717785277], "value": 5645.017129893141, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.263269299892, 479.84405068352794, 483.86209930169906, 490.6835091366068, 515.422726546268, 29772.660230289635, 38776.0, 40165.59834401655, 40211.0, 41699.37450938238, 34902.825485872534, 40078.0, 40491.19017619646, 40947.795261023726, 40955.59044409555, 8114.553699546523, 9110.544472776352, 9277.907220927806, 9290.628374864997, 9305.0, 8332.50004999699, 8551.273141782956, 10805.891941080607, 11040.0, 11057.0, 11120.666380008572, 11166.994970452657, 11172.385518796464, 11182.66452006441, 11192.832107518394, 8288.50268983863, 11037.558497660084, 11133.387663678495, 11134.16493762963, 11144.99999999996, 8306.501609903426, 8449.493030418194, 8453.154684531559, 8484.703035393732, 10829.458527073693, 37784.43323350152, 39447.40828887569, 39536.209275814326, 39594.0, 39756.807295781175, 3219.871205151791, 3235.854386552611, 3268.215628249227, 3502.1069627245142, 3516.859325626972, 28583.14250572486, 29254.561181582292, 29265.268368290752, 29689.9608513701, 29754.553681694793, 3029.833359165245, 3173.4129186100645, 3188.8883889063773, 3195.6484786673445, 3220.146661134801, 471310.7910144052, 474202.0, 474879.0, 475249.0, 475648.0, 58769.412305876394, 58886.0, 59005.40994590085, 59044.40955590475, 59113.0, 61255.693721531105, 61394.079088813705, 61399.0, 61454.0, 61487.07769383463, 15323.923380383027, 15735.291911863993, 15806.130662813655, 15806.9209653951, 15810.288537015862, 11041.0, 11255.887441125647, 12152.027837773134, 12205.45075471606, 12234.571789987307, 16049.0, 16395.0, 16469.752953705705, 16637.334506619598, 16810.32758689663, 6542.892126240093, 6581.967090164519, 6623.569467984566, 6626.337366263431, 6701.698423570951, 831.4553967151404, 935.2237642756496, 935.8596210568332, 972.5088830140875, 985.8422652375585, 28139.341885555157, 28971.710282897322, 29531.852340738158, 29622.407551849272, 29639.85180074129, 1018.9061478661422, 1028.1106842581262, 1056.963006294776, 1110.35044498969, 1128.3624752015248, 14733.705325893423, 15038.699226015418, 15243.923780381027, 15416.46042388511, 15428.845711542965, 613739.0, 614573.0, 615298.0, 618948.0, 619332.0, 56475.152872706945, 56725.43274567201, 56741.43258567444, 56793.14810277849, 56996.0, 1210.195220178589, 1250.9812352814897, 1325.7282257137072, 1361.0948719101884, 1369.3153423288356, 26218.557979310557, 27446.86276568684, 30045.0, 30079.653437674784, 30217.971376096062, 48376.0, 48941.02117957692, 49138.50861491339, 49186.26220606765, 49196.50803491919, 509802.0, 511148.0, 512610.0, 513410.0, 640400.0, 24644.87677561601, 25155.74844251534, 25417.872910635328, 25615.0, 25729.0, 44222.557774421846, 44459.55540444684, 44536.33195502135, 44791.55208447874, 44995.875103122686, 36223.0, 36767.81616091902, 36882.07794805151, 36934.0, 37213.0, 30507.54238686377, 36537.634623654485, 36866.0, 36902.0, 37264.627353726115, 36621.450678239315, 36645.0, 36858.8157059213, 37716.43425348567, 39134.608653914234, 26449.94200231969, 31610.209744755644, 33783.662163379035, 33913.3217335647, 33952.320953581286, 24861.378465537782, 25026.8737906791, 25386.365340866625, 25412.364690882136, 25874.611880821427], "value": 19325.26415733527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.19051490650094, 347.79653902467055, 361.9945700814487, 379.7455704677865, 398.9301872172369, 14708.632284192901, 14969.251537423126, 15865.12741799202, 20038.29865954692, 20433.0, 18879.0, 19695.606087878234, 20333.18667253308, 20553.69169462459, 20636.071376788044, 5542.91685624716, 5822.592418530705, 5831.9416805831825, 5834.620749651259, 5847.970760146193, 4097.528784189826, 4852.539008794177, 5690.63010904292, 5726.513246374063, 5727.484526392624, 4321.438213032317, 4358.476982762073, 6019.097135429699, 6357.046443033536, 6366.872662546746, 6116.418940200719, 6299.811005669837, 6388.64862432566, 6403.167588213526, 6404.167458230447, 5557.888842223173, 5569.359523654791, 5569.916451253234, 5575.2473416088715, 5580.051391263495, 24353.63469547958, 24631.261062167985, 24862.37844053913, 25071.997120115175, 25189.874050629813, 2392.808575313971, 2525.989604158333, 2542.720300766914, 2650.8144429889917, 2879.9712002879915, 14717.411303547846, 15342.616434589114, 15348.386064557404, 16131.516054518383, 16243.106629135393, 1700.5918579540944, 1835.5319393554691, 1856.6750818606824, 1877.4367689693038, 1936.6223586400658, 107308.0, 122038.0, 122822.77177228202, 123718.2884513466, 127299.0, 9068.50123243228, 9493.0, 9883.159931405911, 10240.283180177315, 10576.312539684895, 12114.970227530759, 12508.874911250952, 12602.684932876751, 12603.117781755373, 12629.43167557462, 7781.844363112819, 8088.555129467935, 8099.149589293157, 8185.222403871623, 8194.590270486451, 8397.664093436317, 8438.831223375499, 8494.0, 8556.74329770108, 8592.312614990786, 3829.904252393657, 3941.2708648900043, 3949.921001579952, 3975.582563830756, 4005.5994400560294, 1768.2750072470226, 1891.924323027091, 1926.7398901148447, 1949.76602807664, 1972.3925001124037, 712.515489467157, 719.0903507063568, 731.5281643340016, 828.883956246126, 973.1436336024395, 15738.842611573738, 17316.653666926843, 19854.907980061234, 19947.401577952685, 20549.69175462369, 875.4047247871381, 890.7060669978891, 904.9095090490898, 922.1331947968888, 944.8677185194078, 8851.867221991675, 9548.37935534188, 11096.00135987765, 11297.378644174485, 11402.258853174517, 614624.0, 623186.0, 633730.0, 653293.0, 653642.0, 139770.0, 140237.0, 140251.0, 147647.0, 148773.0, 933.2580598424269, 940.055244479294, 959.8800149981253, 963.1476143613093, 964.3779762053576, 18084.819151808315, 18725.344612938483, 19044.1430135647, 19103.044847757836, 19124.33064842724, 57517.71241143768, 58151.70924145352, 58435.0, 59427.0, 59933.40066599278, 74118.62940685262, 76222.0, 78431.0, 81741.0, 83928.16071839203, 7622.594908975058, 8073.39449541275, 8165.0, 8350.916490835258, 8545.658173672984, 9281.72154835356, 12294.077944154045, 12767.61697149087, 13060.934695326463, 13292.40184191733, 10968.451577420938, 10975.50610222526, 11348.262362946381, 11360.261582997078, 11495.712607184887, 11000.284981476178, 11022.779544408906, 11077.224594278323, 11175.944120279346, 11556.88443115558, 11321.886781132083, 11436.828447573127, 11642.0, 11816.231944923553, 11855.34795586251, 8116.350691944512, 8187.426880118334, 8341.24928756415, 8387.83224335522, 8400.327973761961, 9736.659216927374, 10779.461026948464, 10942.17933654995, 11208.775824483628, 11393.487293071998], "value": 9472.508596343234, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1438.9784153237704, 1467.9192644404557, 1518.5899807052097, 1542.5989242796877, 1570.7643853421991, 8082.838343233139, 8397.53813540255, 8409.369297302705, 8413.906192195022, 8424.199701028409, 7292.067602085452, 7573.204813494573, 7585.582792946386, 7618.695252189919, 7642.388608911274, 2086.937391878246, 2131.009080777438, 2240.9663855042186, 2312.6531020346915, 2325.174563030117, 2346.5658853112227, 2348.9060437582475, 2351.2123438647986, 2351.7883390494853, 2351.870647114408, 2193.7148170737782, 2222.822174226066, 2225.3324002799095, 2225.7869461143714, 2227.888605569723, 2162.8053475187153, 2168.5012447137087, 2282.9086836526517, 2296.816254699628, 2322.907083716649, 2322.6516022596747, 2327.4057270769576, 2340.8010319122723, 2350.189184731265, 2350.6944097267246, 8204.425690201688, 8272.420930534865, 8308.7091951782, 8324.542150181738, 8328.8334233315, 5018.021485810268, 5164.199549069863, 5169.974150129263, 5172.767225474862, 5176.948230517684, 3337.4326364518092, 3483.303339332144, 3490.2670439207795, 3526.5239192708914, 3573.8391772370305, 1020.5458570935937, 1059.3379138038727, 1081.621432498627, 1101.8732845722764, 1108.5953626926193, 9422.0, 10731.248812583122, 10830.67507974762, 10866.61966831157, 10876.673699789018, 3682.613325600827, 4544.568266014723, 4616.469106052779, 4617.746023968647, 4726.26742854858, 9263.722088337361, 9266.119718626855, 9283.535823208947, 9303.162715355651, 9317.487538185329, 5149.871253218625, 5150.356205474316, 5150.407703114115, 5153.5361817436615, 5157.0975079361715, 4594.494605593382, 4656.092062047868, 4710.717356958594, 4727.763611819395, 4731.503192164842, 3500.1949551602765, 3633.7456378053284, 3647.179384638488, 3710.7216958728204, 3845.9807700961314, 1166.1370585766472, 1175.7707247086908, 1182.7457096724074, 1184.8815118488255, 1190.4880901212562, 834.0575150080371, 847.9781862855244, 861.7457849934284, 898.5552151684827, 902.2060586683676, 5159.922601160985, 5509.807156749494, 5509.862253443615, 5818.563607729353, 6005.189299444606, 848.8217474330336, 939.3236869453982, 946.597695979206, 960.6541645007792, 975.2685485885586, 3647.7993710345654, 3783.05423644089, 3842.269968705937, 3853.190829925747, 3895.902602434962, 9767.0, 9922.0, 10019.198464122852, 10025.448600327052, 10097.646582369729, 9289.442633442015, 9665.951670241604, 9982.500874956224, 9987.750306242257, 9994.150497207673, 7437.590932498656, 7744.535327880345, 7749.4575379724, 7755.7673269802, 7759.952406425174, 4457.2645513489915, 5471.425500322409, 5478.233047373451, 5619.522340600931, 5641.915371269516, 8908.198262156437, 9006.63973441055, 9152.313576481658, 9183.862242066241, 9272.768180795534, 9253.722388328091, 9320.161185493338, 9335.533223338942, 9418.199453046294, 9445.52772361393, 7160.57036577807, 7230.783076507713, 7623.313901748869, 7779.688812447439, 7784.377249819888, 7499.737509187153, 7597.810054748676, 7707.959425477488, 7720.8455830884195, 7735.303822655988, 6914.55055421396, 6935.167779866247, 6951.131108611424, 7034.788956331318, 7121.750738724119, 6836.623985680636, 6838.658067096725, 6929.133858267716, 7015.473839461959, 7022.508424410242, 6480.157579514633, 6504.9674751625935, 6591.274959754327, 6596.043573681885, 6600.438962688226, 4668.229742092517, 4800.679813051439, 4809.687370320918, 4853.150698627796, 4969.925451118308, 4801.399825021872, 4806.303086052433, 4862.635302352409, 4914.655974081923, 4979.103761322996], "value": 4360.8248975011475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.3947275186004, 306.47133694377203, 311.1552135950894, 317.71247021445583, 320.7289840085127, 4724.480307166214, 4915.35335662553, 4994.602590756439, 5188.766505507252, 5249.658772179806, 4358.978205108978, 5011.498850114996, 5111.463296353885, 5111.974440127803, 5185.170372740362, 3566.8216589170565, 4024.7182697211206, 4033.1731994941115, 4040.333344998079, 4068.023674318157, 3565.786052836825, 3978.661813745835, 4051.6758659307184, 4056.8782936511952, 4073.87778366648, 3535.7524973251884, 3728.9254214915686, 3779.8488060477684, 4004.679625629957, 4019.778912159845, 3572.6070132285427, 3809.2381523695235, 3996.680265578747, 4001.97999010006, 4007.4189242559664, 2895.4788138135127, 2937.2950491882007, 2986.925326866824, 3279.4097062528735, 3554.129238336598, 5042.571381432583, 5097.923531147036, 5115.2327150927285, 5125.538701516882, 5151.459096794858, 3917.764934103963, 4487.349334346534, 4490.550944905516, 4501.864944051684, 4526.479454862667, 4847.733374664392, 4929.531694489017, 5119.948800512022, 5164.612654050961, 5363.436839131874, 3758.248350329945, 3770.736803170941, 3781.962180378216, 3786.3941769316775, 3794.31702293587, 5122.436531981479, 5424.728763561846, 5734.311882574035, 5766.298941812175, 5812.8837423251725, 3215.8070515769127, 3513.8755598208327, 3795.6963442925053, 3803.8478460861256, 3826.8277927492773, 3380.7295416366633, 3796.354619714655, 3836.8081595920094, 3889.7277190596387, 3899.0642245861354, 3828.5405751310022, 4425.535318791545, 4446.866594002185, 4480.596746292849, 4489.438820147481, 4689.968206994456, 5091.643584949018, 5482.698451585201, 5509.752061157257, 5559.305086864142, 1043.1081425381342, 1141.869549146339, 1180.6186761489078, 1234.7160153164823, 1242.2670374827246, 836.5858899844616, 845.9003295715668, 858.5449711652834, 860.0625318402846, 860.1484530314943, 4334.046509767846, 4612.123696497655, 4806.519348065235, 4829.710217386968, 4859.757012149449, 5238.345206849144, 5253.789848406097, 5294.232336311214, 5300.70846103468, 5343.583950253186, 4217.599328063829, 4264.701470897007, 4533.124178827121, 4779.5220477951925, 4826.490225083007, 2636.986815065912, 2640.4949178968186, 2845.6158418613636, 2851.329937464694, 2862.298736809453, 5533.833984980457, 5533.897119094719, 5549.528290095387, 5550.666959982414, 5551.805686800943, 5445.863853403617, 5480.054580623901, 5492.231087647732, 5513.892150348016, 5601.8599535011135, 4450.732956022649, 5454.836354909438, 5675.2054712340305, 5899.168399168338, 5939.406658971347, 5284.603654725834, 5400.108982017923, 5703.173039909273, 5763.827085187451, 5805.506531944832, 5398.811041613525, 5693.829185124453, 5703.743331550173, 5712.914306285492, 5738.0777439558215, 4843.927341089957, 4977.925331119964, 5609.887802244014, 5861.296644402529, 5979.790707325223, 3575.374309495776, 3894.415837624379, 3902.4390243902667, 3902.4780335668543, 3916.2754890345377, 5053.797848086182, 5398.946010539844, 5489.866974378969, 5716.571257155813, 5769.480746732815, 4947.3321101652255, 5420.0, 5454.563634909277, 5458.699771512605, 5604.971975140098, 4433.512313645432, 5513.614047016831, 5557.861053473695, 5569.637973531708, 5599.468050535193, 4617.74449013438, 5290.365156181283, 5331.493508116722, 5402.51377376038, 5454.236406903116, 4992.750362481789, 5221.242919776687, 5494.972525137348, 5554.3894369646205, 5576.972115139399, 4620.491745908014, 4979.626528010486, 5123.923141152811, 5431.185322201702, 5441.551301914075], "value": 3958.1883286794546, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.4186525184098, 756.3684323589803, 766.9194734552872, 773.9342155916747, 783.471156969046, 14012.579622611313, 14362.42550297988, 15706.764398534016, 16359.0, 16407.0, 14966.476173333935, 15129.0, 15140.86443516738, 15154.393824247018, 15164.317605707742, 640.5996252342286, 658.9868202635945, 812.5571563497908, 836.6820608168917, 837.7863644770605, 791.2917938445117, 816.873384625384, 822.7613991942329, 828.1842385250524, 828.8673812190051, 872.8559787635032, 875.4528419737663, 876.7150676030284, 879.7492714576347, 885.3979294080023, 679.5345188545862, 868.0, 869.8564736818449, 869.9864657673802, 871.5816408124073, 526.4866754913967, 549.2063967566868, 645.0743183531647, 654.8493846415304, 657.4773055420952, 14067.929660351632, 14102.083364581269, 14102.506412275521, 14108.506202282872, 14116.647083822883, 12389.690257743538, 12526.498940042387, 12535.0, 12563.811542826774, 12724.300163491096, 9135.720999060071, 11317.83023254652, 11331.490082946288, 11969.64091077269, 12197.45111469977, 3649.799261040642, 3661.212839239576, 3674.4488326750934, 3783.810809459516, 3791.8672846450518, 87704.0, 90258.0, 91417.0, 92313.99999999933, 92594.53702731444, 10182.389056656624, 10276.0, 10358.378497290036, 10358.689239322832, 10397.58409663605, 19773.0, 19945.301914432926, 19961.301354452815, 19975.900120499304, 20035.699464508045, 7073.717051317993, 7309.5248808827255, 7371.226021267797, 7522.097348318128, 7572.167061623217, 4108.1783643271465, 4188.267053265667, 4277.743335399886, 4294.76378799169, 4400.405945197422, 3340.0, 3387.3902697514686, 3387.5765529308837, 3403.676650718178, 3457.27397246576, 635.1520719839067, 636.8885445047191, 645.6094063091762, 648.1768154443924, 648.2577448821168, 541.0, 548.9313835770529, 579.5942840012009, 614.5790133758389, 651.4169818012947, 7032.648367581601, 8741.300695944436, 8818.382713210014, 9100.499472529074, 9597.760055998657, 643.6910283064155, 665.653859992801, 674.6458109492555, 680.421641604642, 689.5207830557814, 4165.708630324549, 4444.799984000728, 4452.621527170162, 4475.686701930834, 4533.342665313511, 76587.61706191434, 101650.47524287141, 109759.0, 112083.0, 116768.0, 95834.0, 97164.0, 99392.0, 103239.45140822894, 103890.4416433739, 82408.17591824125, 87245.56377218201, 87792.42959844161, 88274.11725882787, 88848.5557572208, 8344.66621335164, 8581.8712719308, 8808.163224493663, 8880.289576833968, 9022.14289642483, 44006.339904900815, 51046.23430648469, 56324.15513767215, 56605.15092273537, 58399.0, 40786.796066020666, 53364.0, 59171.704141479015, 66811.66594166998, 74096.25903740893, 11161.55353785872, 11727.706807329885, 11782.410879456163, 12122.212056216671, 12492.937535312265, 13951.302434878013, 14143.0, 14287.785683214968, 14377.856221437652, 15190.240487975778, 12876.452572063778, 13076.673083172996, 13370.06409551322, 13574.117682350616, 13635.0, 12557.748845022865, 12767.93616031951, 12894.871051289367, 13273.336333183495, 13897.888168946258, 10298.742531436774, 12153.210041347284, 13092.803607945698, 13118.606441806762, 13554.796678049639, 10534.315269507457, 10763.3541987481, 10899.0, 11718.648440546796, 12065.698357540781, 11047.779044418905, 11067.616547931508, 11324.123485112765, 11462.0, 11602.709932251424], "value": 7215.6030244929, "unit": "score"}], "name": "dromaeo_css", "value": 7105.700720113761, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 116.0, 113.0, 114.0, 115.0, 119.0, 166.0, 123.0, 112.0], "value": 120.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 113.0, 144.0, 112.0, 118.0, 137.0, 137.0, 155.0, 110.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 184.0, 183.0, 184.0, 182.0, 184.0, 182.0, 185.0, 182.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 81.0, 114.0, 63.0, 63.0, 58.0, 58.0, 84.0, 59.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 93.0, 70.0, 68.0, 69.0, 88.0, 67.0, 69.0, 94.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 88.0, 85.0, 88.0, 85.0, 90.0, 88.0, 87.0, 84.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 95.0, 96.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 93.0, 131.0, 109.0, 85.0, 86.0, 127.0, 126.0, 128.0], "value": 104.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 57.0, 58.0, 59.0, 59.0, 57.0, 58.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 72.0, 67.0, 75.0, 74.0, 68.0, 69.0, 69.0, 69.0, 69.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 84.0, 81.0, 83.0, 83.0, 83.0, 83.0, 82.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 144.0, 152.0, 151.0, 134.0, 143.0, 145.0, 143.0, 185.0, 145.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 164.0, 163.0, 165.0, 163.0, 164.0, 163.0, 163.0, 161.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 85.0, 82.0, 85.0, 84.0, 84.0, 80.0, 66.0, 66.0], "value": 75.9, "unit": "score"}], "name": "kraken", "value": 1467.2000000000003, "alertThreshold": 2.0}]} 09:10:07 INFO - Return code: 0 09:10:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:10:07 INFO - # TBPL SUCCESS # 09:10:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:10:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:10:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:10:07 INFO - 2017-01-07 09:10:07.458 screenresolution[1662:11519] starting screenresolution argv=screenresolution get 09:10:07 INFO - 2017-01-07 09:10:07.460 screenresolution[1662:11519] Display 0: 1600x1200x32@60 09:10:07 INFO - 2017-01-07 09:10:07.466 screenresolution[1663:11522] starting screenresolution argv=screenresolution list 09:10:07 INFO - Available Modes on Display 0 09:10:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:10:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:10:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:10:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:10:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:10:07 INFO - Intel Iris: 09:10:07 INFO - Chipset Model: Intel Iris 09:10:07 INFO - Type: GPU 09:10:07 INFO - Bus: Built-In 09:10:07 INFO - VRAM (Dynamic, Max): 1536 MB 09:10:07 INFO - Vendor: Intel (0x8086) 09:10:07 INFO - Device ID: 0x0a2e 09:10:07 INFO - Revision ID: 0x0009 09:10:07 INFO - Displays: 09:10:07 INFO - Display: 09:10:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:10:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:10:07 INFO - Display Serial Number: 1600x1200 60 09:10:07 INFO - Main Display: Yes 09:10:07 INFO - Mirror: Off 09:10:07 INFO - Online: Yes 09:10:07 INFO - Rotation: Supported 09:10:07 INFO - Return code: 0 09:10:07 INFO - Running post-action listener: _resource_record_post_action 09:10:07 INFO - [mozharness: 2017-01-07 17:10:07.705988Z] Finished run-tests step (success) 09:10:07 INFO - Running post-run listener: _resource_record_post_run 09:10:07 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 33074176; Write bytes: 658979840; Read time: 315; Write time: 1872 09:10:07 INFO - TinderboxPrint: CPU usage
53.6% 09:10:07 INFO - TinderboxPrint: I/O read bytes / time
33,074,176 / 315 09:10:07 INFO - TinderboxPrint: I/O write bytes / time
658,979,840 / 1,872 09:10:07 INFO - TinderboxPrint: CPU idle
2,248.4 (46.4%) 09:10:07 INFO - TinderboxPrint: CPU system
973.9 (20.1%) 09:10:07 INFO - TinderboxPrint: CPU user
1,627.3 (33.6%) 09:10:07 INFO - TinderboxPrint: Swap in / out
377,958,400 / 0 09:10:07 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 345258496; Write bytes: 346167296; Read time: 27002; Write time: 671 09:10:07 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31112192; Write bytes: 305869824; Read time: 296; Write time: 1173 09:10:08 INFO - Running post-run listener: _upload_blobber_files 09:10:08 INFO - Blob upload gear active. 09:10:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:10:08 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 09:10:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:10:08 INFO - (blobuploader) - INFO - Open directory for files ... 09:10:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:10:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:10:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:09 INFO - (blobuploader) - INFO - Done attempting. 09:10:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:10:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:10:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:10 INFO - (blobuploader) - INFO - Done attempting. 09:10:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:10:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:10:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:12 INFO - (blobuploader) - INFO - Done attempting. 09:10:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:10:12 INFO - Return code: 0 09:10:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:10:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:10:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ba0c47783ccb6022f0232c6720f70be990213b7917f170d72b5ce8e93a517192cb1fd49d06c9579885b07bbf32771f089e666282a92fd431c157aa578c8614a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cc0ddd9c9ef1b511852ef9fd54077ae326280891b53595751ee93d76b92ca34d02768c1db6d8eb9d899dd388fadaa3dc994f675ff68574bbe43a5065a5ca62d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f3d4a69c2bbc0f2e3f2e44a49098f27706d1bd9ff37bdb612c800a7de24ec031edc0f63711ccc6b084c39a717c44a46beef08858acbfa01aa1def0d3ea21f0c"} 09:10:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:10:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:10:12 INFO - Contents: 09:10:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ba0c47783ccb6022f0232c6720f70be990213b7917f170d72b5ce8e93a517192cb1fd49d06c9579885b07bbf32771f089e666282a92fd431c157aa578c8614a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cc0ddd9c9ef1b511852ef9fd54077ae326280891b53595751ee93d76b92ca34d02768c1db6d8eb9d899dd388fadaa3dc994f675ff68574bbe43a5065a5ca62d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f3d4a69c2bbc0f2e3f2e44a49098f27706d1bd9ff37bdb612c800a7de24ec031edc0f63711ccc6b084c39a717c44a46beef08858acbfa01aa1def0d3ea21f0c"} 09:10:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:10:12 INFO - Copying logs to upload dir... 09:10:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:10:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.508800 ========= master_lag: 0.52 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-01-07 09:10:13.059818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 09:10:13.067336) ========= 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.RxFDWdNRDK/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.0R86a1HTzT/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ba0c47783ccb6022f0232c6720f70be990213b7917f170d72b5ce8e93a517192cb1fd49d06c9579885b07bbf32771f089e666282a92fd431c157aa578c8614a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cc0ddd9c9ef1b511852ef9fd54077ae326280891b53595751ee93d76b92ca34d02768c1db6d8eb9d899dd388fadaa3dc994f675ff68574bbe43a5065a5ca62d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f3d4a69c2bbc0f2e3f2e44a49098f27706d1bd9ff37bdb612c800a7de24ec031edc0f63711ccc6b084c39a717c44a46beef08858acbfa01aa1def0d3ea21f0c"} build_url:https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/N4moMNQIRP-F-v--2V8j1w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ba0c47783ccb6022f0232c6720f70be990213b7917f170d72b5ce8e93a517192cb1fd49d06c9579885b07bbf32771f089e666282a92fd431c157aa578c8614a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cc0ddd9c9ef1b511852ef9fd54077ae326280891b53595751ee93d76b92ca34d02768c1db6d8eb9d899dd388fadaa3dc994f675ff68574bbe43a5065a5ca62d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f3d4a69c2bbc0f2e3f2e44a49098f27706d1bd9ff37bdb612c800a7de24ec031edc0f63711ccc6b084c39a717c44a46beef08858acbfa01aa1def0d3ea21f0c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 09:10:13.110303) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 09:10:13.110697) ========= 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.RxFDWdNRDK/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.0R86a1HTzT/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.005225 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 09:10:13.161800) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 09:10:13.165258) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 09:10:13.165674) ========= ========= Total master_lag: 0.68 =========