builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0095 starttime: 1484649192.19 results: success (0) buildid: 20170117004014 builduid: 3bb2baae90e441e6a5ac9e51669a917b revision: d306f88dfd3a8701053073ae78d435d06e907d9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:12.188469) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:12.188955) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:12.189296) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:12.216793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:12.217099) ========= 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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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-17 02:33:12-- 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% 142M=0s 2017-01-17 02:33:12 (142 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148935 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:12.390593) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:12.390983) ========= 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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.027556 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:12.440071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-17 02:33:12.440430) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d306f88dfd3a8701053073ae78d435d06e907d9c --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 d306f88dfd3a8701053073ae78d435d06e907d9c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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-17 02:33:12,534 truncating revision to first 12 chars 2017-01-17 02:33:12,534 Setting DEBUG logging. 2017-01-17 02:33:12,534 attempt 1/10 2017-01-17 02:33:12,534 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d306f88dfd3a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-17 02:33:13,239 unpacking tar archive at: mozilla-aurora-d306f88dfd3a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.993920 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-17 02:33:13.461561) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:13.462320) ========= script_repo_revision: d306f88dfd3a8701053073ae78d435d06e907d9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:13.463331) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:13.464056) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:13.485392) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-01-17 02:33:13.486091) ========= /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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:33:13 INFO - MultiFileLogger online at 20170117 02:33:13 in /builds/slave/test 02:33:13 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 02:33:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:33:13 INFO - {'append_to_log': False, 02:33:13 INFO - 'base_work_dir': '/builds/slave/test', 02:33:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:33:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:33:13 INFO - 'branch': 'Mozilla-Aurora', 02:33:13 INFO - 'buildbot_json_path': 'buildprops.json', 02:33:13 INFO - 'config_files': ('talos/mac_config.py',), 02:33:13 INFO - 'default_actions': ('clobber', 02:33:13 INFO - 'read-buildbot-config', 02:33:13 INFO - 'download-and-extract', 02:33:13 INFO - 'populate-webroot', 02:33:13 INFO - 'create-virtualenv', 02:33:13 INFO - 'install', 02:33:13 INFO - 'run-tests'), 02:33:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:33:13 INFO - 'download_minidump_stackwalk': True, 02:33:13 INFO - 'download_symbols': 'ondemand', 02:33:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:33:13 INFO - 'tooltool.py': '/tools/tooltool.py', 02:33:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:33:13 INFO - '/tools/misc-python/virtualenv.py')}, 02:33:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:33:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:33:13 INFO - 'installer_path': 'installer.exe', 02:33:13 INFO - 'log_level': 'info', 02:33:13 INFO - 'log_name': 'talos', 02:33:13 INFO - 'log_to_console': True, 02:33:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:33:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:33:13 INFO - 'opt_config_files': (), 02:33:13 INFO - 'pip_index': False, 02:33:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:33:13 INFO - 'cmd': ('bash', 02:33:13 INFO - '-c', 02:33:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:33:13 INFO - 'enabled': True, 02:33:13 INFO - 'halt_on_failure': False, 02:33:13 INFO - 'name': 'check_screen_resolution'},), 02:33:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:33:13 INFO - 'cmd': ('bash', 02:33:13 INFO - '-c', 02:33:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:33:13 INFO - 'enabled': True, 02:33:13 INFO - 'halt_on_failure': False, 02:33:13 INFO - 'name': 'check_screen_resolution'},), 02:33:13 INFO - 'run_cmd_checks_enabled': True, 02:33:13 INFO - 'sps_profile': False, 02:33:13 INFO - 'sps_profile_interval': 0, 02:33:13 INFO - 'suite': 'dromaeojs', 02:33:13 INFO - 'system_bits': '32', 02:33:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:33:13 INFO - 'title': 't-yosemite-r7-0095', 02:33:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:33:13 INFO - 'use_talos_json': True, 02:33:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:33:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:33:13 INFO - 'work_dir': 'build'} 02:33:13 INFO - [mozharness: 2017-01-17 10:33:13.693445Z] Running clobber step. 02:33:13 INFO - Running pre-action listener: _resource_record_pre_action 02:33:13 INFO - Running main action method: clobber 02:33:13 INFO - rmtree: /builds/slave/test/build 02:33:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:33:16 INFO - Running post-action listener: _resource_record_post_action 02:33:16 INFO - [mozharness: 2017-01-17 10:33:16.051450Z] Finished clobber step (success) 02:33:16 INFO - [mozharness: 2017-01-17 10:33:16.051595Z] Running read-buildbot-config step. 02:33:16 INFO - Running pre-action listener: _resource_record_pre_action 02:33:16 INFO - Running main action method: read_buildbot_config 02:33:16 INFO - Using buildbot properties: 02:33:16 INFO - { 02:33:16 INFO - "project": "", 02:33:16 INFO - "product": "firefox", 02:33:16 INFO - "script_repo_revision": "production", 02:33:16 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:33:16 INFO - "repository": "", 02:33:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:33:16 INFO - "buildid": "20170117004014", 02:33:16 INFO - "stage_platform": "macosx64", 02:33:16 INFO - "basedir": "/builds/slave/test", 02:33:16 INFO - "nightly_build": "True", 02:33:16 INFO - "buildnumber": 77, 02:33:16 INFO - "slavename": "t-yosemite-r7-0095", 02:33:16 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:33:16 INFO - "platform": "yosemite_r7", 02:33:16 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:33:16 INFO - "branch": "mozilla-aurora", 02:33:16 INFO - "repo_path": "releases/mozilla-aurora", 02:33:16 INFO - "revision": "d306f88dfd3a8701053073ae78d435d06e907d9c", 02:33:16 INFO - "pgo_build": "False", 02:33:16 INFO - "builduid": "3bb2baae90e441e6a5ac9e51669a917b", 02:33:16 INFO - "slavebuilddir": "test" 02:33:16 INFO - } 02:33:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 02:33:16 INFO - Running post-action listener: _resource_record_post_action 02:33:16 INFO - [mozharness: 2017-01-17 10:33:16.055023Z] Finished read-buildbot-config step (success) 02:33:16 INFO - [mozharness: 2017-01-17 10:33:16.055153Z] Running download-and-extract step. 02:33:16 INFO - Running pre-action listener: _resource_record_pre_action 02:33:16 INFO - Running main action method: download_and_extract 02:33:16 INFO - mkdir: /builds/slave/test/build/tests 02:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:16 INFO - trying https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 02:33:16 INFO - Downloading https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/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 02:33:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/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 02:33:17 INFO - Downloaded 1199 bytes. 02:33:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:33:17 INFO - Using the following test package requirements: 02:33:17 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:33:17 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:17 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 02:33:17 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:17 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 02:33:17 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:17 INFO - u'jsshell-mac.zip'], 02:33:17 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:17 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 02:33:17 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:33:17 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:17 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 02:33:17 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:17 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 02:33:17 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:17 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 02:33:17 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:17 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 02:33:17 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:33:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:33:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:33:17 INFO - Fetch https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:33:17 INFO - Http code: 200 02:33:17 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 02:33:17 INFO - x-amz-cf-id: 7Di0p8x3Czk17Q2ahxwisUoli0RJ0y2OWrwKzaE5r5rMW64eSw4W3A== 02:33:17 INFO - x-amz-version-id: ElGmDoasOVCFwrG5waYHPr.psTfoh1YH 02:33:18 INFO - Expected file size: 16275917 02:33:18 INFO - Obtained file size: 16275917 02:33:24 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 02:33:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:33:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:33:24 INFO - Fetch https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:33:25 INFO - Http code: 200 02:33:25 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 02:33:25 INFO - x-amz-cf-id: E5LCxOCtbAN8hCRwWwxu3ZsxJlAPDWUkm3-ZcCzSOMq3Fr5KVxqg9A== 02:33:25 INFO - x-amz-version-id: ElGmDoasOVCFwrG5waYHPr.psTfoh1YH 02:33:25 INFO - Expected file size: 16275917 02:33:25 INFO - Obtained file size: 16275917 02:33:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 02:33:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:33:32 INFO - Fetch https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 02:33:32 INFO - Http code: 200 02:33:32 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 02:33:32 INFO - x-amz-cf-id: 71wcDaGRXYdFn9PW4Bcn-WaujepIyKj6xEgmYjx9W33Nm6skhZ2AbA== 02:33:32 INFO - x-amz-version-id: L2E2LUEgG0IYf1Vq_X39yL4pnchzHb7q 02:33:33 INFO - Expected file size: 14409038 02:33:33 INFO - Obtained file size: 14409038 02:33:33 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')]} 02:33:33 INFO - trying https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:33:33 INFO - Downloading https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 02:33:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/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 02:33:36 INFO - Downloaded 110049864 bytes. 02:33:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:33:36 INFO - mkdir: /builds/slave/test/properties 02:33:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:33:36 INFO - Writing to file /builds/slave/test/properties/build_url 02:33:36 INFO - Contents: 02:33:36 INFO - build_url:https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:33:37 INFO - Running post-action listener: _resource_record_post_action 02:33:37 INFO - Running post-action listener: set_extra_try_arguments 02:33:37 INFO - [mozharness: 2017-01-17 10:33:37.263822Z] Finished download-and-extract step (success) 02:33:37 INFO - [mozharness: 2017-01-17 10:33:37.263984Z] Running populate-webroot step. 02:33:37 INFO - Running pre-action listener: _resource_record_pre_action 02:33:37 INFO - Running main action method: populate_webroot 02:33:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:33:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:33:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:33:37 INFO - '--tppagecycles', 02:33:37 INFO - '7'], 02:33:37 INFO - 'tests': ['tsvgm']}}, 02:33:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:33:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:33:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:33:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:33:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:33:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:33:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:37 INFO - 'talos_options': ['--disable-e10s'], 02:33:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:37 INFO - 'talos_options': ['--disable-e10s'], 02:33:37 INFO - 'tests': ['damp', 'tps']}, 02:33:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:37 INFO - 'tests': ['damp', 'tps']}, 02:33:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:33:37 INFO - 'tests': ['dromaeo_dom']}, 02:33:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:33:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:33:37 INFO - 'tests': ['basic_compositor_video']}, 02:33:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:33:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:33:37 INFO - 'tests': ['a11yr', 02:33:37 INFO - 'ts_paint', 02:33:37 INFO - 'tpaint', 02:33:37 INFO - 'sessionrestore', 02:33:37 INFO - 'sessionrestore_no_auto_restore', 02:33:37 INFO - 'tabpaint']}, 02:33:37 INFO - 'other-e10s': {'tests': ['a11yr', 02:33:37 INFO - 'ts_paint', 02:33:37 INFO - 'tpaint', 02:33:37 INFO - 'sessionrestore', 02:33:37 INFO - 'sessionrestore_no_auto_restore', 02:33:37 INFO - 'tabpaint']}, 02:33:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:33:37 INFO - 'ts_paint', 02:33:37 INFO - 'tpaint', 02:33:37 INFO - 'sessionrestore', 02:33:37 INFO - 'sessionrestore_no_auto_restore', 02:33:37 INFO - 'tabpaint']}, 02:33:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:33:37 INFO - 'ts_paint', 02:33:37 INFO - 'tpaint', 02:33:37 INFO - 'sessionrestore', 02:33:37 INFO - 'sessionrestore_no_auto_restore', 02:33:37 INFO - 'tabpaint']}, 02:33:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:33:37 INFO - 'tests': ['a11yr', 02:33:37 INFO - 'ts_paint', 02:33:37 INFO - 'tpaint', 02:33:37 INFO - 'sessionrestore', 02:33:37 INFO - 'sessionrestore_no_auto_restore', 02:33:37 INFO - 'tabpaint']}, 02:33:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:33:37 INFO - 'tests': ['a11yr', 02:33:37 INFO - 'ts_paint', 02:33:37 INFO - 'tpaint', 02:33:37 INFO - 'sessionrestore', 02:33:37 INFO - 'sessionrestore_no_auto_restore', 02:33:37 INFO - 'tabpaint']}, 02:33:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:33:37 INFO - 'tests': ['tsvgx', 02:33:37 INFO - 'tsvgr_opacity', 02:33:37 INFO - 'tart', 02:33:37 INFO - 'tscrollx', 02:33:37 INFO - 'cart']}, 02:33:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:33:37 INFO - 'tsvgr_opacity', 02:33:37 INFO - 'tart', 02:33:37 INFO - 'tscrollx', 02:33:37 INFO - 'cart']}, 02:33:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:37 INFO - 'talos_options': ['--disable-e10s'], 02:33:37 INFO - 'tests': ['tp5o']}, 02:33:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:37 INFO - 'tests': ['tp5o']}, 02:33:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:37 INFO - 'talos_options': ['--disable-e10s', 02:33:37 INFO - '--xperf_path', 02:33:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:37 INFO - 'tests': ['tp5n']}, 02:33:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:37 INFO - 'talos_options': ['--xperf_path', 02:33:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:37 INFO - 'tests': ['tp5n']}}, 02:33:37 INFO - 'talos.zip': {'path': '', 02:33:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:33:37 INFO - Running post-action listener: _resource_record_post_action 02:33:37 INFO - [mozharness: 2017-01-17 10:33:37.281114Z] Finished populate-webroot step (success) 02:33:37 INFO - [mozharness: 2017-01-17 10:33:37.281193Z] Running create-virtualenv step. 02:33:37 INFO - Running pre-action listener: _resource_record_pre_action 02:33:37 INFO - Running main action method: create_virtualenv 02:33:37 INFO - Creating virtualenv /builds/slave/test/build/venv 02:33:37 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 02:33:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:33:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:33:37 INFO - Using real prefix '/tools/python27' 02:33:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:33:38 INFO - Installing distribute.............................................................................................................................................................................................done. 02:33:41 INFO - Installing pip.................done. 02:33:41 INFO - Return code: 0 02:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:33:41 INFO - Reading from file tmpfile_stdout 02:33:41 INFO - Output received: 02:33:41 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) 02:33:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:33:41 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')]} 02:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:41 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')]} 02:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:41 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 0x1062d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10624d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0c1d84dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060ebd30>, '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 0x105f51db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3b20>, '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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:33:41 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 02:33:41 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 02:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uuX3KNWuP6/Render', 02:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:41 INFO - 'HOME': '/Users/cltbld', 02:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:41 INFO - 'LOGNAME': 'cltbld', 02:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:41 INFO - 'MOZ_NO_REMOTE': '1', 02:33:41 INFO - 'NO_EM_RESTART': '1', 02:33:41 INFO - 'PAGER': '/bin/cat', 02:33:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:41 INFO - 'PWD': '/builds/slave/test', 02:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:41 INFO - 'SHELL': '/bin/bash', 02:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hQ6kHz0KG0/Listeners', 02:33:41 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:41 INFO - 'USER': 'cltbld', 02:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:41 INFO - 'XPC_FLAGS': '0x0', 02:33:41 INFO - 'XPC_SERVICE_NAME': '0', 02:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:41 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 02:33:41 INFO - Cleaning up... 02:33:41 INFO - Return code: 0 02:33:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:33:41 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')]} 02:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:41 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')]} 02:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:41 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 0x1062d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10624d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0c1d84dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060ebd30>, '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 0x105f51db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3b20>, '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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:33:41 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 02:33:41 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 02:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uuX3KNWuP6/Render', 02:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:41 INFO - 'HOME': '/Users/cltbld', 02:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:41 INFO - 'LOGNAME': 'cltbld', 02:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:41 INFO - 'MOZ_NO_REMOTE': '1', 02:33:41 INFO - 'NO_EM_RESTART': '1', 02:33:41 INFO - 'PAGER': '/bin/cat', 02:33:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:41 INFO - 'PWD': '/builds/slave/test', 02:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:41 INFO - 'SHELL': '/bin/bash', 02:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hQ6kHz0KG0/Listeners', 02:33:41 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:41 INFO - 'USER': 'cltbld', 02:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:41 INFO - 'XPC_FLAGS': '0x0', 02:33:41 INFO - 'XPC_SERVICE_NAME': '0', 02:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:41 INFO - Downloading/unpacking psutil>=3.1.1 02:33:41 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 02:33:41 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 02:33:41 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 02:33:41 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 02:33:41 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 02:33:41 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 02:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:33:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:45 INFO - Installing collected packages: psutil 02:33:45 INFO - Running setup.py install for psutil 02:33:45 INFO - building 'psutil._psutil_osx' extension 02:33:45 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 02:33:46 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 02:33:46 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 02:33:46 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 02:33:46 INFO - building 'psutil._psutil_posix' extension 02:33:46 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 02:33:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:33:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:33:46 INFO - ^ 02:33:46 INFO - 1 warning generated. 02:33:46 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 02:33:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:46 INFO - Successfully installed psutil 02:33:46 INFO - Cleaning up... 02:33:46 INFO - Return code: 0 02:33:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:33:46 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')]} 02:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:46 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')]} 02:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:46 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 0x1062d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10624d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0c1d84dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060ebd30>, '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 0x105f51db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3b20>, '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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:33:46 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 02:33:46 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 02:33:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uuX3KNWuP6/Render', 02:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:46 INFO - 'HOME': '/Users/cltbld', 02:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:46 INFO - 'LOGNAME': 'cltbld', 02:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:46 INFO - 'MOZ_NO_REMOTE': '1', 02:33:46 INFO - 'NO_EM_RESTART': '1', 02:33:46 INFO - 'PAGER': '/bin/cat', 02:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:46 INFO - 'PWD': '/builds/slave/test', 02:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:46 INFO - 'SHELL': '/bin/bash', 02:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hQ6kHz0KG0/Listeners', 02:33:46 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:46 INFO - 'USER': 'cltbld', 02:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:46 INFO - 'XPC_FLAGS': '0x0', 02:33:46 INFO - 'XPC_SERVICE_NAME': '0', 02:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:33:46 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 02:33:46 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 02:33:46 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 02:33:46 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 02:33:46 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 02:33:46 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 02:33:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:33:49 INFO - Installing collected packages: mozsystemmonitor 02:33:49 INFO - Running setup.py install for mozsystemmonitor 02:33:49 INFO - Successfully installed mozsystemmonitor 02:33:49 INFO - Cleaning up... 02:33:49 INFO - Return code: 0 02:33:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:49 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 0x1062d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10624d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0c1d84dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060ebd30>, '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 0x105f51db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3b20>, '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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:33:49 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 02:33:49 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 02:33:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uuX3KNWuP6/Render', 02:33:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:49 INFO - 'HOME': '/Users/cltbld', 02:33:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:49 INFO - 'LOGNAME': 'cltbld', 02:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:49 INFO - 'MOZ_NO_REMOTE': '1', 02:33:49 INFO - 'NO_EM_RESTART': '1', 02:33:49 INFO - 'PAGER': '/bin/cat', 02:33:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:49 INFO - 'PWD': '/builds/slave/test', 02:33:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:49 INFO - 'SHELL': '/bin/bash', 02:33:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hQ6kHz0KG0/Listeners', 02:33:49 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:33:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:49 INFO - 'USER': 'cltbld', 02:33:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:49 INFO - 'XPC_FLAGS': '0x0', 02:33:49 INFO - 'XPC_SERVICE_NAME': '0', 02:33:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:50 INFO - Downloading/unpacking jsonschema==2.5.1 02:33:50 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 02:33:50 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 02:33:50 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 02:33:50 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 02:33:50 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 02:33:50 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 02:33:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:33:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:33:52 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 02:33:52 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 02:33:52 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 02:33:52 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 02:33:52 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 02:33:52 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 02:33:53 INFO - Downloading functools32-3.2.3-2.tar.gz 02:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:33:53 INFO - warning: no files found matching '*.txt' 02:33:53 INFO - no previously-included directories found matching 'build' 02:33:53 INFO - no previously-included directories found matching 'dist' 02:33:53 INFO - no previously-included directories found matching '.git*' 02:33:53 INFO - Installing collected packages: jsonschema, functools32 02:33:53 INFO - Running setup.py install for functools32 02:33:53 INFO - warning: no files found matching '*.txt' 02:33:53 INFO - no previously-included directories found matching 'build' 02:33:53 INFO - no previously-included directories found matching 'dist' 02:33:53 INFO - no previously-included directories found matching '.git*' 02:33:53 INFO - Successfully installed jsonschema functools32 02:33:53 INFO - Cleaning up... 02:33:53 INFO - Return code: 0 02:33:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:53 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 0x1062d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10624d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0c1d84dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060ebd30>, '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 0x105f51db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3b20>, '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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:33:53 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 02:33:53 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 02:33:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uuX3KNWuP6/Render', 02:33:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:53 INFO - 'HOME': '/Users/cltbld', 02:33:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:53 INFO - 'LOGNAME': 'cltbld', 02:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:53 INFO - 'MOZ_NO_REMOTE': '1', 02:33:53 INFO - 'NO_EM_RESTART': '1', 02:33:53 INFO - 'PAGER': '/bin/cat', 02:33:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:53 INFO - 'PWD': '/builds/slave/test', 02:33:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:53 INFO - 'SHELL': '/bin/bash', 02:33:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hQ6kHz0KG0/Listeners', 02:33:53 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:33:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:53 INFO - 'USER': 'cltbld', 02:33:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:53 INFO - 'XPC_FLAGS': '0x0', 02:33:53 INFO - 'XPC_SERVICE_NAME': '0', 02:33:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:33:53 INFO - Cleaning up... 02:33:53 INFO - Return code: 0 02:33:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:53 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 0x1062d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10624d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0c1d84dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060ebd30>, '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 0x105f51db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3b20>, '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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:33:53 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 02:33:53 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 02:33:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uuX3KNWuP6/Render', 02:33:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:53 INFO - 'HOME': '/Users/cltbld', 02:33:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:53 INFO - 'LOGNAME': 'cltbld', 02:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:53 INFO - 'MOZ_NO_REMOTE': '1', 02:33:53 INFO - 'NO_EM_RESTART': '1', 02:33:53 INFO - 'PAGER': '/bin/cat', 02:33:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:53 INFO - 'PWD': '/builds/slave/test', 02:33:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:53 INFO - 'SHELL': '/bin/bash', 02:33:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hQ6kHz0KG0/Listeners', 02:33:53 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:33:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:53 INFO - 'USER': 'cltbld', 02:33:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:53 INFO - 'XPC_FLAGS': '0x0', 02:33:53 INFO - 'XPC_SERVICE_NAME': '0', 02:33:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:53 INFO - Downloading/unpacking blobuploader==1.2.4 02:33:53 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 02:33:53 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 02:33:53 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 02:33:53 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 02:33:53 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 02:33:53 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 02:33:56 INFO - Downloading blobuploader-1.2.4.tar.gz 02:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:33:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:33:56 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 02:33:56 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 02:33:56 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 02:33:56 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 02:33:56 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 02:33:56 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 02:33:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:33:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:33:57 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 02:33:57 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 02:33:57 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 02:33:57 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 02:33:57 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 02:33:57 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 02:33:57 INFO - Downloading docopt-0.6.1.tar.gz 02:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:33:58 INFO - Installing collected packages: blobuploader, requests, docopt 02:33:58 INFO - Running setup.py install for blobuploader 02:33:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:33:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:33:58 INFO - Running setup.py install for requests 02:33:58 INFO - Running setup.py install for docopt 02:33:58 INFO - Successfully installed blobuploader requests docopt 02:33:58 INFO - Cleaning up... 02:33:59 INFO - Return code: 0 02:33:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:59 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 0x1062d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10624d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0c1d84dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060ebd30>, '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 0x105f51db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3b20>, '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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:33:59 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 02:33:59 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 02:33:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uuX3KNWuP6/Render', 02:33:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:59 INFO - 'HOME': '/Users/cltbld', 02:33:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:59 INFO - 'LOGNAME': 'cltbld', 02:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:59 INFO - 'MOZ_NO_REMOTE': '1', 02:33:59 INFO - 'NO_EM_RESTART': '1', 02:33:59 INFO - 'PAGER': '/bin/cat', 02:33:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:59 INFO - 'PWD': '/builds/slave/test', 02:33:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:59 INFO - 'SHELL': '/bin/bash', 02:33:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hQ6kHz0KG0/Listeners', 02:33:59 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:33:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:59 INFO - 'USER': 'cltbld', 02:33:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:59 INFO - 'XPC_FLAGS': '0x0', 02:33:59 INFO - 'XPC_SERVICE_NAME': '0', 02:33:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:59 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-coVPlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:59 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-WasMIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:59 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Jl_VUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:59 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-clSZrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:59 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-NNmdKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:59 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-JXzQT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:59 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-5wRaiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:34:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-kElm2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:34:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-JGAwht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:34:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-A9ETDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:34:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-lwIJIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:34:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-5iqzIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:34:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-WAEix9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:34:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-2UlraJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-f1HEoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:34:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-J5gv8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:34:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-fjHLoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:34:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:34:01 INFO - Running setup.py install for manifestparser 02:34:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:34:01 INFO - Running setup.py install for mozcrash 02:34:01 INFO - Running setup.py install for mozdebug 02:34:01 INFO - Running setup.py install for mozdevice 02:34:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:34:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:34:01 INFO - Running setup.py install for mozfile 02:34:01 INFO - Running setup.py install for mozhttpd 02:34:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:34:01 INFO - Running setup.py install for mozinfo 02:34:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:34:02 INFO - Running setup.py install for mozInstall 02:34:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:34:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:34:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:34:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:34:02 INFO - Running setup.py install for mozleak 02:34:02 INFO - Running setup.py install for mozlog 02:34:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:34:02 INFO - Running setup.py install for moznetwork 02:34:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:34:02 INFO - Running setup.py install for mozprocess 02:34:02 INFO - Running setup.py install for mozprofile 02:34:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:34:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:34:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:34:03 INFO - Running setup.py install for mozrunner 02:34:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:34:03 INFO - Running setup.py install for mozscreenshot 02:34:03 INFO - Running setup.py install for moztest 02:34:03 INFO - Running setup.py install for mozversion 02:34:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:34:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:34:03 INFO - Cleaning up... 02:34:03 INFO - Return code: 0 02:34:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:03 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 0x1062d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10624d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0c1d84dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060ebd30>, '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 0x105f51db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3b20>, '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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:34:03 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 02:34:03 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 02:34:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uuX3KNWuP6/Render', 02:34:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:03 INFO - 'HOME': '/Users/cltbld', 02:34:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:03 INFO - 'LOGNAME': 'cltbld', 02:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:03 INFO - 'MOZ_NO_REMOTE': '1', 02:34:03 INFO - 'NO_EM_RESTART': '1', 02:34:03 INFO - 'PAGER': '/bin/cat', 02:34:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:03 INFO - 'PWD': '/builds/slave/test', 02:34:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:03 INFO - 'SHELL': '/bin/bash', 02:34:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hQ6kHz0KG0/Listeners', 02:34:03 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:34:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:03 INFO - 'USER': 'cltbld', 02:34:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:03 INFO - 'XPC_FLAGS': '0x0', 02:34:03 INFO - 'XPC_SERVICE_NAME': '0', 02:34:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:34:03 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-__ppwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:34:04 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)) 02:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:34:04 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-sKvsQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:34:04 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)) 02:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:34:04 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-brRoZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:34:04 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)) 02:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:34:04 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-29Taub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:34:04 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)) 02:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:34:04 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Fb48rE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:34:04 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)) 02:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:34:04 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-G2w0j0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:34:04 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)) 02:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:34:04 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-vD7Cx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:34:04 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)) 02:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:34:04 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-MzRXm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:34:04 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)) 02:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:34:04 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-eF0Su7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:34:04 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)) 02:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:34:04 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-qNc7qS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:34:05 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)) 02:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:34:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-a3D5Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:34:05 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)) 02:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:34:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Q1va3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:34:05 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)) 02:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:34:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-QCxEWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:34:05 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)) 02:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:34:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-MpdNa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:34:05 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)) 02:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-NAQH8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:05 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)) 02:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:34:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-5GdmVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:34:05 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)) 02:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:34:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-UhanqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:34:05 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)) 02:34:05 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)) 02:34:05 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)) 02:34:05 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)) 02:34:05 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)) 02:34:05 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)) 02:34:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:08 INFO - Downloading blessings-1.6.tar.gz 02:34:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:34:08 INFO - Installing collected packages: blessings 02:34:08 INFO - Running setup.py install for blessings 02:34:08 INFO - Successfully installed blessings 02:34:08 INFO - Cleaning up... 02:34:08 INFO - Return code: 0 02:34:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:34:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:34:08 INFO - Reading from file tmpfile_stdout 02:34:08 INFO - Current package versions: 02:34:08 INFO - blessings == 1.6 02:34:08 INFO - blobuploader == 1.2.4 02:34:08 INFO - docopt == 0.6.1 02:34:08 INFO - functools32 == 3.2.3-2 02:34:08 INFO - jsonschema == 2.5.1 02:34:08 INFO - manifestparser == 1.1 02:34:08 INFO - mozInstall == 1.12 02:34:08 INFO - mozcrash == 1.0 02:34:08 INFO - mozdebug == 0.1 02:34:08 INFO - mozdevice == 0.48 02:34:08 INFO - mozfile == 1.2 02:34:08 INFO - mozhttpd == 0.7 02:34:08 INFO - mozinfo == 0.9 02:34:08 INFO - mozleak == 0.1 02:34:08 INFO - mozlog == 3.4 02:34:08 INFO - moznetwork == 0.27 02:34:08 INFO - mozprocess == 0.23 02:34:08 INFO - mozprofile == 0.28 02:34:08 INFO - mozrunner == 6.13 02:34:08 INFO - mozscreenshot == 0.1 02:34:08 INFO - mozsystemmonitor == 0.3 02:34:08 INFO - moztest == 0.8 02:34:08 INFO - mozversion == 1.4 02:34:08 INFO - psutil == 3.1.1 02:34:08 INFO - requests == 1.2.3 02:34:08 INFO - wsgiref == 0.1.2 02:34:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:09 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')]} 02:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:09 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 0x1062d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10624d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0c1d84dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060ebd30>, '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 0x105f51db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3b20>, '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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:34:09 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 02:34:09 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 02:34:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uuX3KNWuP6/Render', 02:34:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:09 INFO - 'HOME': '/Users/cltbld', 02:34:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:09 INFO - 'LOGNAME': 'cltbld', 02:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:09 INFO - 'MOZ_NO_REMOTE': '1', 02:34:09 INFO - 'NO_EM_RESTART': '1', 02:34:09 INFO - 'PAGER': '/bin/cat', 02:34:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:09 INFO - 'PWD': '/builds/slave/test', 02:34:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:09 INFO - 'SHELL': '/bin/bash', 02:34:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hQ6kHz0KG0/Listeners', 02:34:09 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:34:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:09 INFO - 'USER': 'cltbld', 02:34:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:09 INFO - 'XPC_FLAGS': '0x0', 02:34:09 INFO - 'XPC_SERVICE_NAME': '0', 02:34:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:10 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)) 02:34:10 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)) 02:34:10 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)) 02:34:10 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)) 02:34:10 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)) 02:34:10 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)) 02:34:10 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)) 02:34:10 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)) 02:34:10 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)) 02:34:10 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)) 02:34:10 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)) 02:34:10 INFO - Cleaning up... 02:34:10 INFO - Return code: 0 02:34:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10624d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0c1d84dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060ebd30>, '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 0x105f51db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3b20>, '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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:34:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uuX3KNWuP6/Render', 02:34:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:10 INFO - 'HOME': '/Users/cltbld', 02:34:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:10 INFO - 'LOGNAME': 'cltbld', 02:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:10 INFO - 'MOZ_NO_REMOTE': '1', 02:34:10 INFO - 'NO_EM_RESTART': '1', 02:34:10 INFO - 'PAGER': '/bin/cat', 02:34:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:10 INFO - 'PWD': '/builds/slave/test', 02:34:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:10 INFO - 'SHELL': '/bin/bash', 02:34:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hQ6kHz0KG0/Listeners', 02:34:10 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:34:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:10 INFO - 'USER': 'cltbld', 02:34:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:10 INFO - 'XPC_FLAGS': '0x0', 02:34:10 INFO - 'XPC_SERVICE_NAME': '0', 02:34:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:34:10 INFO - Cleaning up... 02:34:10 INFO - Return code: 0 02:34:10 INFO - Running post-action listener: _resource_record_post_action 02:34:10 INFO - Running post-action listener: _start_resource_monitoring 02:34:10 INFO - Starting resource monitoring. 02:34:10 INFO - [mozharness: 2017-01-17 10:34:10.709841Z] Finished create-virtualenv step (success) 02:34:10 INFO - [mozharness: 2017-01-17 10:34:10.710882Z] Running install step. 02:34:10 INFO - Running pre-action listener: _resource_record_pre_action 02:34:10 INFO - Running main action method: install 02:34:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:34:10 INFO - Reading from file tmpfile_stdout 02:34:10 INFO - Detecting whether we're running mozinstall >=1.0... 02:34:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:34:11 INFO - Reading from file tmpfile_stdout 02:34:11 INFO - Output received: 02:34:11 INFO - Usage: mozinstall [options] installer 02:34:11 INFO - Options: 02:34:11 INFO - -h, --help show this help message and exit 02:34:11 INFO - -d DEST, --destination=DEST 02:34:11 INFO - Directory to install application into. [default: 02:34:11 INFO - "/builds/slave/test"] 02:34:11 INFO - --app=APP Application being installed. [default: firefox] 02:34:11 INFO - mkdir: /builds/slave/test/build/application 02:34:11 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'] 02:34:11 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 02:34:42 INFO - Reading from file tmpfile_stdout 02:34:42 INFO - Output received: 02:34:42 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:34:42 INFO - Running post-action listener: _resource_record_post_action 02:34:42 INFO - [mozharness: 2017-01-17 10:34:42.404585Z] Finished install step (success) 02:34:42 INFO - [mozharness: 2017-01-17 10:34:42.404749Z] Running run-tests step. 02:34:42 INFO - Running pre-action listener: _resource_record_pre_action 02:34:42 INFO - Running main action method: run_tests 02:34:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:34:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:34:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:34:42 INFO - 2017-01-17 02:34:42.419 screenresolution[1624:7349] starting screenresolution argv=screenresolution get 02:34:42 INFO - 2017-01-17 02:34:42.421 screenresolution[1624:7349] Display 0: 1600x1200x32@60 02:34:42 INFO - 2017-01-17 02:34:42.427 screenresolution[1625:7351] starting screenresolution argv=screenresolution list 02:34:42 INFO - Available Modes on Display 0 02:34:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:34:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:34:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:34:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:34:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:34:42 INFO - Intel Iris: 02:34:42 INFO - Chipset Model: Intel Iris 02:34:42 INFO - Type: GPU 02:34:42 INFO - Bus: Built-In 02:34:42 INFO - VRAM (Dynamic, Max): 1536 MB 02:34:42 INFO - Vendor: Intel (0x8086) 02:34:42 INFO - Device ID: 0x0a2e 02:34:42 INFO - Revision ID: 0x0009 02:34:42 INFO - Displays: 02:34:42 INFO - Display: 02:34:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:34:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:34:42 INFO - Display Serial Number: 1600x1200 60 02:34:42 INFO - Main Display: Yes 02:34:42 INFO - Mirror: Off 02:34:42 INFO - Online: Yes 02:34:42 INFO - Rotation: Supported 02:34:42 INFO - Return code: 0 02:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:34:42 INFO - Python 2.7.3 02:34:42 INFO - Return code: 0 02:34:42 INFO - grabbing minidump binary from tooltool 02:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060ebd30>, '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 0x105f51db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:34:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:34:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:34:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:34:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:34:42 INFO - Return code: 0 02:34:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:34:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:34:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:34:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:34:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:34:42 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/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0095', '--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 02:34:42 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/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0095 --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 02:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uuX3KNWuP6/Render', 02:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:42 INFO - 'HOME': '/Users/cltbld', 02:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:42 INFO - 'LOGNAME': 'cltbld', 02:34:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:34:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:42 INFO - 'MOZ_NO_REMOTE': '1', 02:34:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:34:42 INFO - 'NO_EM_RESTART': '1', 02:34:42 INFO - 'PAGER': '/bin/cat', 02:34:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:42 INFO - 'PWD': '/builds/slave/test', 02:34:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:42 INFO - 'SHELL': '/bin/bash', 02:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hQ6kHz0KG0/Listeners', 02:34:42 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:42 INFO - 'USER': 'cltbld', 02:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:42 INFO - 'XPC_FLAGS': '0x0', 02:34:42 INFO - 'XPC_SERVICE_NAME': '0', 02:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:42 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/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0095', '--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 02:34:43 INFO - mozversion application_buildid: 20170117004014 02:34:43 INFO - mozversion application_changeset: d306f88dfd3a8701053073ae78d435d06e907d9c 02:34:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:34:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:34:43 INFO - mozversion application_name: Firefox 02:34:43 INFO - mozversion application_remotingname: firefox-dev 02:34:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:34:43 INFO - mozversion application_vendor: Mozilla 02:34:43 INFO - mozversion application_version: 52.0a2 02:34:43 INFO - mozversion platform_buildid: 20170117004014 02:34:43 INFO - mozversion platform_changeset: d306f88dfd3a8701053073ae78d435d06e907d9c 02:34:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:34:43 INFO - mozversion platform_version: 52.0a2 02:34:43 INFO - using testdate: 1484649283 02:34:43 INFO - actual date: 1484649283 02:34:43 INFO - starting webserver on 'localhost:49241' 02:34:43 INFO - SUITE-START | Running 2 tests 02:34:43 INFO - TEST-START | dromaeo_css 02:34:43 INFO - operating with platform_type : mac_ 02:34:43 INFO - Initialising browser for dromaeo_css test... 02:34:43 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmp0uCqP1/profile http://localhost:49241/getInfo.html) 02:34:45 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 02:34:45 INFO - PROCESS | 1635 | colorDepth:24 02:34:45 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 02:34:45 INFO - PROCESS | 1635 | __metrics 02:34:45 INFO - PROCESS | 1635 | 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" 02:34:45 INFO - PROCESS | 1635 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:34:46 INFO - TEST-INFO | 1635: exit 0 02:34:46 INFO - Browser initialized. 02:34:46 INFO - Running cycle 1/1 for dromaeo_css test... 02:34:46 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmp0uCqP1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:34:58 INFO - PROCESS | 1638 | RSS: Main: 221609984 02:34:58 INFO - PROCESS | 1638 | 02:38:03 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 02:38:05 INFO - PROCESS | 1638 | RSS: Main: 330895360 02:38:05 INFO - PROCESS | 1638 | 02:41:07 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 02:41:08 INFO - PROCESS | 1638 | RSS: Main: 347627520 02:41:08 INFO - PROCESS | 1638 | 02:44:10 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 02:44:11 INFO - PROCESS | 1638 | RSS: Main: 328785920 02:44:11 INFO - PROCESS | 1638 | 02:47:13 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 02:47:14 INFO - PROCESS | 1638 | RSS: Main: 312987648 02:47:14 INFO - PROCESS | 1638 | 02:50:18 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 02:50:18 INFO - PROCESS | 1638 | RSS: Main: 308641792 02:50:18 INFO - PROCESS | 1638 | 02:53:21 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 02:53:21 INFO - PROCESS | 1638 | RSS: Main: 362684416 02:53:21 INFO - PROCESS | 1638 | 02:53:21 INFO - PROCESS | 1638 | __start_tp_report 02:53:21 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 02:53:21 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 02:53:21 INFO - PROCESS | 1638 | |i|pagename|runs| 02:53:21 INFO - PROCESS | 1638 | |0;dojo.html;3317.452620317648;3340.8830690925824;3351.4302568563344;3357.832108394581;3407.2163402417445;5563.888722225558;5625.746841392137;5672;5676.063449530828;5689.089745640704;5558.416366281543;5590.488508606107;5656.575756818244;5661.46216109469;5688.857778555538;5094.617903657222;5121.078205922932;5141.742912854361;5170.793168273283;5197.66215196011;5127.179651255799;5131.204663277198;5146.536811686948;5221.530062294392;5263.789448422078;4813.975930120345;5177.068127737006;5199.740012999335;5205.16717325228;5205.193195054753;5191.480851914835;5232.398274198478;5252.395974462909;5254.632175747699;5285.4450282720145;5074.3657042869645;5077.822276220351;5166.560842328407;5183.2743415921805;5201.973990130063;5576.665400076008;5594.888102237973;5605.934872374236;5622.156676498517;5642.915356269659;6108;6157.415045570664;6171.197744293213;6182.5363097767395;6202.131701561785;5112.565431938289;6026.397360263939;6254.437100660963;6273.341299163568;6277.905831412532;5627.493525582676;5638.23883775685;5668.688222147739;5679.545636349082;5716.771329146871;6258.311585725566;6301.779437719658;6308.495320374359;6314.368563143649;6326.272478665012;6067.514598832083;6070.757169713162;6086.147939288503;6103;6111;4583.518730533313;5863.384344643751;6053.727582258721;6135.570510064253;6183.134361189437;6045.8488537786025;6048.727807248684;6049.5462840287155;6057.969710151421;6065.909011364833;5010.574101201366;6077.908831367533;6114.0828875669;6121.785737499255;6122.54080943931;4824.372831531879;4864.610831133501;4885.267209918469;4887.193613053877;4917.532834380728;4337.869863904088;4339.717918335298;4340.674449416307;4373.081652852937;4390.692651514363;5532.30846144232;5583.497485226268;5717.256756621613;5722.62802917809;5725.31296244445;6109.9816581254145;6126.242866754769;6182.876342473125;6191.907121393183;6257.687115644199;5615.578831587565;5680.176374425685;5692.373838877803;5693.402192769782;5702.657840529581;5342.652727572696;5350.705711185922;5361.437049109787;5361.651492652965;5375;6170.413810687977;6270.059491076375;6280.152179455715;6284.811455656338;6302.086197501429;4631.421072365954;6125.418593525838;6155.384461553809;6194.907076393948;6218.129461875432;6181.474574661204;6209.441150296495;6233.532485063729;6234.594751341148;6237.345078766664;6078;6092;6122.142899994094;6147.815565533041;6153.692315384303;5902.350741418526;6119.106526814713;6128.655903792346;6133.854967165127;6167.599106058092;4951.257311403318;6044.576879618385;6055.515558755377;6090.3605121461605;6098.390160984043;5959.851003724942;6008.579399441997;6017.879642407215;6024.156618073385;6041.335453100068;5688.40271771458;5747.396523364986;5754.510866576388;5854.385289544707;5882.411758824083;5949.869524790449;5969.283685957713;5971.313298970674;6016.578839481194;6103.84740381494;4839.782209800497;5837.919984802825;5871.530277577869;5910.320313163869;5933.199018132497 02:53:21 INFO - PROCESS | 1638 | |1;ext.html;506.6200349737697;518.9377274727032;526.9420363759983;537.2505355029733;541.6587549843598;30346.393072138544;38642.806785966066;40033.799831000804;40112.59887401125;40168.19663606726;40663.39004914921;41339.79330103345;41785;41902;41951.79024104875;9305.162535371815;9495.240380769523;9500.71497855062;9512;9516.952415237914;9333.439993600407;9425;9435.716928492122;9441.961384247727;9442.669506567272;9412.294077944147;9421.057894210559;9447.763805904839;9471.147596716293;9538.761530961712;9386.765330866749;9436.716898493056;9443.527823608862;9446.763830904283;9453.810923781486;9287.210587100104;9371;9375.296852736004;9377.062293770636;9381.5309234538;39247.21505569901;39505.60494395077;39518.60481395178;39534.406983895264;39584.802075989726;3121.750259979196;3243.4486137356707;3264.2329052672603;3287.852046657906;3293.4071867063917;29337.973170938916;29986;30061.413863694062;30244.69755302441;30568.69431305703;3143.528470729386;3182.633997090341;3195.6325022622464;3195.9360812783616;3277.573915390984;478758;479341;483849;485793;496579;33062.842800501865;59553.51116222129;59809;59936.70031649901;60068.699656501434;34041.48937765935;34622.65377346244;35026.474602880975;35090.64909350925;35129.47305790415;14375.353109110116;14527.418903243963;14527.491537796337;14545.345459454138;14551.345189466289;12272.079594030483;12331.445084971198;12350.44423000967;12354.876451235552;12381.380930953417;7698.2686644768655;7711.768646940601;7788.14330423653;7799.103103143211;7816.921830781733;3166.1293144385477;3172.1435212492497;3216.212028053142;3227.5320078588475;3266.9673303267136;858.2704701004096;882.969096081634;903.1826197291462;955.9713208603614;1075.9515821788038;28320.575191372147;29397.251670978098;29859.850700746792;30006.849965750032;30401.543976840367;719.1909102259957;878.8198419324151;979.7997453119871;1009.6369900634086;1017.3285631483186;12881.291528965809;13568.93215533916;15099.094054356774;15437.922810385877;15438.5368438947;656681;876949;887649;888509;891517;58663.70668146632;59316.40683593195;59437;59444;59521.10718339228;1193.1111322065117;1231.3658465889894;1231.7967535356925;1327.82074419954;1353.986460135386;24404.6339304907;30397;30990.915317964664;31530.211744706565;32295.67704322927;54095.188572172236;54693.179602306795;54772.90454190974;54844.45155548393;54921.72539137279;595947;600960;601532;601709;603426;26238.60642090332;26604.201873943814;26859.194224173305;26891.731082688922;27025.59461608038;44246;45462;45891;46375.84060398517;46582.76708616435;37093;38428.84713458601;38678.03304917287;38947.6105238944;39555.60444395519;37033.074173145884;37358.439623406215;37851.432228517144;37961;39199.216015678954;31660.5250921241;33547.83226083854;36718.082047949014;38011.619883800806;38149.427758583086;31366.58850351694;33573.83213083919;33690.157746056546;34139.4879076819;34403.483947741304;25199.49601007933;25315;25346.239612811645;25607.103751368613;25899.352516187246 02:53:21 INFO - PROCESS | 1638 | |2;jquery.html;368.59638695628286;369.3665363900911;382.1287464580755;384.66341950793054;400.555383524288;18354.81645183548;19135.043247837606;19413.223471061177;19567.119479623434;19764.505887352825;19779.60440791187;20128.698069528968;20172.899135504304;20261.696074558895;20658.69011964818;5583.6928968906695;5689.8577535561635;5863.648181109147;5957.225560677106;5974.253218347707;3858.8070596470207;5909.852253693671;5946.672932988684;5951.22634057574;5957.165996760457;4072.735272207312;4084.9183016339657;7258.782236532912;7606.695732170734;7682.385409167281;7550.207228241065;7569.205233450491;7720.691172353099;7891.644875980594;7992.160823113606;7425.405967522585;7722.536647801094;7737.4970626909635;7764.107127680276;7800.609969501502;20671.689924651142;26342.341441464116;26619.733802661918;26880;27279.772410241585;2212.5906707259046;2546.312495626189;2574.845509269431;2779.332960089584;3186.5698130752285;15274.474856147137;15679.92160039204;16622.916885415496;16729.996200228026;17610.91194544032;1837.2926423326983;2022.787607301227;2027.0574183004974;2068.9482762930897;2073.2121793718443;135888.6411135886;136683;143396.28301858425;150179.24910375488;151663.24168379197;17294.90908727441;21261.68107478389;22229;22238.332850014525;22396.664050039264;36139.09652258662;36145.81927090348;36903.81548092242;36963.63036369602;36965.63034369676;10789.514471848786;10874.401907894984;10880.891191088147;10966.725831854268;11162.609308674157;9000.774980625536;9006.954965225132;9015.14356136166;9020.881487578152;9164.083591640783;8058;9631.08504692053;9708.611655533841;9898.158656514133;9913.206943444507;2961.763058955278;3581.6690477855323;3675.6875665568728;3687.9815600921825;3695.74129810916;829.2578142562373;939.6147579492375;949.8337790886567;958.2046901072093;987.4717026390847;19417.708734368996;19799;20802.47993800137;20945;20951.371458856258;753.6570860258569;904.1546154345708;916.9587368568431;917.2111983694151;920.1580553793337;10439.37363758177;10988.945055274673;11004.504797284142;11029.61396351124;11061.612843550438;584584;593721;600625;608131;609559;127209.36395317964;128318;130867;135913;136701;947.8862536495665;949.8100379924043;956.8038552096804;966.7728083900278;969.3989726369555;17101.48695539136;17938.91030544839;18424.539386515444;18527.166277517274;18580;50490.39701662692;54767.72616136894;55479.445205547425;55541.1668824976;55633.72183139058;79990;80815.57553273412;82867.17132828594;83093;83376.33247334899;5672.4894759471845;7293.635318234174;7391.630418478947;7421.740239091606;8055.1944805521325;10002.649907253211;10429.374237545771;11893.821592675944;12230.388480575757;12475.500979961063;10470.842937356098;10484.528196231035;10521.842172367573;10546;10997.12023038171;9961.701148965543;10510.054095131474;10699.89804907493;10816.566272588605;10978.451077446256;10838.67483975482;10872.782544348911;11087.05760010408;11241.49413276388;11313.943430282796;7160.99746035545;7303.926960730325;7340.486165968545;7395.852082958203;7567.848643027219;8346.332293416634;10229.84655230187;10735.94632026835;10806;11140.721481963015 02:53:21 INFO - PROCESS | 1638 | |3;mootools.html;1465.9853401465984;1486.346007756587;1654.925528351224;1801.531601783536;1848.7226915962613;8012.719554815582;8445.662173513067;8452.112528184536;8462.153784621534;8468.70359537417;6564.737410503574;7429.6285185740635;7663.118741344747;7681.193474685161;8172.101068882418;2301.631738921769;2346.0263990443946;2348.659444380564;2349.9647505287435;2352.694149760529;2296.6784650148993;2305.723313202418;2310.4570425949887;2348.729896061949;2360.9173678921243;2311.3181611424584;2322.535492901418;2346.77705617966;2347.8943447544816;2351.6354964980455;1941.4078705994737;2304.1820153845397;2327.1622216002224;2327.2320134355623;2335.7897789198882;2323.314622186459;2354.658574506704;2355.729091154522;2359.398353419867;2360.634101714237;6945.617991010492;8284.751457456287;8343.374246931504;8345.165483451667;8345.95827020861;5011.924821127686;5143.485651434864;5172.405173405069;5181.145111056671;5194.35070616173;3192.5211218317204;3270.084376374619;3488.0582242794303;3526.770759900598;3545.308664810363;937.5921474158763;1032.7211652853762;1062.13966686983;1063.1813503602184;1072;10452.529636166391;10756.19328550362;10782.73043173919;10791.892081079168;10888;4179.874603761892;4302.634276086567;4364.367166760865;4482.148391805546;4500.684952053325;8503.022152452424;8510.191531804468;8512.106228846005;8524.531150786643;8542.658293668184;4440.711353761995;4931.7040977541465;4939.0121975605025;4940.876478088005;4953.653244272867;4224.514180869178;4281.250781113293;4454.955450445519;4645.605123564535;4731.361266229083;3509.894703158909;3560.8753693620597;3613.728970327236;3639.94540081899;3672.06362377592;1069.7058308965097;1086.9347839129518;1091.6506717850211;1100.9889901101046;1101.54285971321;880.8282384935004;887.1350433327455;887.5207388010402;907.3240435875183;907.6233363154349;5438.15708565173;5698.914516282259;5799.768009279582;5857.736401861926;5869.7945571904775;871.7646235516376;893.8167675626481;897.210454799772;919.4529255093208;971.2278738402987;3307.107081088093;3747.5315585551807;3750.774953502799;3854.383298672199;3914.256291304643;9885.25860560461;10048.799024019625;10308.639197628198;10319.329243599143;10335;10267.229957753198;10270.845937310947;10271.024252695983;10276.794464110675;10309.329893556895;7759;7760.456768026184;7760.728374506865;7850.332721718718;7877.724279650185;5352.384475785335;5476.315460567429;5594.552435805207;5646.3788983212635;5753;9315.441073535609;9398.530073496435;9536;9539.379940303857;9545.809083818423;9331.529849815217;9368.297377696836;9465.763355916157;9737.07497787709;9770;6243.313235544178;6477.77327793525;6481.773137940149;6732.057511948429;6853.554518956252;7683;7868.8819667706175;7974.5215287082965;8052.235037671412;8070.677172913018;7050.25972272904;7130.500864939404;7170.677319520739;7237.240089790496;7303.671334789841;6808.114945057111;6983.087291079717;7079.752208672672;7102.5028248022145;7189.2810718927685;6625.635590042594;6646.4350530205475;6747.460203183831;6754.155730533684;6755.662216889037;4889.364382630235;4896.608271338213;4908.9754551227015;4915;4940.011997600423;4494.808875648021;4846.273059041172;4872.4883887192755;4987.426445958616;4996.550310471929 02:53:21 INFO - PROCESS | 1638 | |4;prototype.html;260.9099860548111;299.60601808621675;302.56581805109664;309.4723496438572;313.1904028087394;4408.889777755549;4699.38907941968;4774.785134668944;4849.975750121249;5126.205438157087;4763.499162939458;4874.512548745124;4915.655904086715;4920.80316787329;5089.720065396402;3868.936042588283;3894.7663140211534;3895.4935858338376;3921.8234529641136;3933.2133573285314;3504.141485336096;3607.4408466687705;3901.726879118463;3920.470736450571;3948.506436695413;3000.294930691286;3205.4710972689477;3382.7632065755283;3873.612638736118;3891.299566078105;3074;3397.4394224952975;3472.774269672463;3789.1663833956486;3813.80930953454;3338.315645292709;3339.6493368196475;3344.5484859543894;3346.4901324006996;3355.580552430946;4492.977535112336;4894.437139728905;4900.607951363882;4928.33467481889;4930.457649658535;3385.0014245797547;3565.94651080234;4061.208064427438;4321.395004699345;4363.978180109111;4837.298591704183;5211.42674305826;5236.6857988520815;5284.841454756363;5304;3624.6194149614175;3648.543932008499;3654.3604869147794;3655.9268814623824;3684.244729830378;4503.482099558527;5188.896222075613;5270.075108314883;5580.218769372291;5585.301837270341;3809.904752381213;3853.094522787143;3853.5183102112237;3853.8651147210276;3874.767513949172;3931.3906344516645;3934.449177115206;3934.803259836997;3939.92120157601;3944.8027598619956;4231.434369283324;4457.977710111429;4468.463784345834;4520.756791882259;4548.977255113769;5098.546914129455;5324.361076670824;5346.786128554814;5356.598255130881;5414.35027796667;1252.311228824143;1268.9428975696117;1274.49020391844;1284.4027527199896;1290.5031562848371;834.0616806093145;852.7484392104344;853.317346123099;853.8804567360575;856.2122846980793;4578;4817.879553011203;5032.547070763649;5053.36832895888;5060.7216603086445;4717.9292310615365;5365.95363904035;5478.082671065095;5506.724663766796;5538.75075621598;3788.337041017811;4113.958860411418;4824.917357825816;4848;5000.2749601307605;2688.0994866719475;2707.2555047362134;2715.9049433269743;2733.671959364849;2734.6991830898587;4739.478657347689;4762;5353.598480114007;5386.326709161355;5387.542058924957;4513.75174365413;4846.660733748674;5107.61692873036;5348.893022139613;5355.357357117093;4414.757188354542;4938.234573641092;5133.408643320583;5281.207818827206;5382.650127741685;4721.929171062368;5136.8202112927365;5138.76875540609;5173.611979101507;5193.052605273023;4267.50923643785;4559.993602814751;4853.273693699834;5146.9963357145;5186.870328241824;5331.280277162534;5354.519562284546;5362.65142765719;5379.1393377059485;5416.322959630046;3093.6287645482685;3392.508086327518;3592.0243865874186;3594.4248920172645;3639.9636003639625;4960.454350021567;4985.900281994413;5072.923906141337;5114.695752583068;5256.448072952285;4356.208171011862;4941.77762000718;4990.5508504234795;5009.416384008591;5016.021875734343;4085.3871919212356;4326.459192600925;4569.680122391401;4613.192691278946;4831.236598641541;4337;4562.612177964777;4619.983603607201;4970.801167953386;5227.320448341691;4468.352088947149;5148.794048238028;5248.370195576403;5275.129603615361;5339.092354299701;5213.296205012275;5216.626434972154;5232.8168514103345;5248.448912864094;5270.578353731616 02:53:21 INFO - PROCESS | 1638 | |5;yui.html;681.8772620928232;717.243308309733;751.812046988253;762.4053238473989;776.8174478997438;13220.669483262911;14461.710765784692;14596.394396616364;14634.341454634541;14635.487757928475;12383.69040773981;12749.362531873416;12866.742665146692;13064.93467532661;13296.800547991788;807.1323327423029;816.5060138616141;821.9424640275183;822.3462347433774;823.5717426937989;644.5294934697673;669.8492839111185;671.7816709569385;671.8186089755764;673.3502170405558;706.1279320039747;833.2667252817512;853.0019876744193;856.6873091321654;858.5750053723416;846.8052347960004;847.7117779954783;847.7626264645909;848.084069205263;849.6091797773032;504.8485454363676;627.2191122053027;627.2786295759867;627.5011365964069;628.6228263042138;11213.66359009231;11895.94052029743;11962.043036557141;13031.283279419627;13390;13453.461861525528;13687.24720140392;13780.724385512234;13914.165150091027;13931;10545.578176872916;10821.621243256448;10953.945230273797;10962.616308429167;11022.50398732059;3603.3153700796765;3626.184108575576;3633.2370202257293;3698.704103671727;3709;85031.574842126;86937.13062869417;88376.55811720964;93272.53363733138;93299.53350233274;10295.74260643475;10371.636992705218;10449.164066874631;10498.10766084876;10498.370097794157;19953.501162471053;19998;20139.59720805605;20152.69770953437;20197;7299.489035767551;7471.925280747231;7665.731699390494;7678;7744.92255077442;4139.19285739284;4146.958530414718;4306.440162778818;4375.868723938287;4441.600255976913;3384.5430866833153;3449.534312867781;3455.0560406523678;3495.318412909509;3499.8775042873376;584.7660935625698;586.2320360327984;587.1369087441454;591.2461611445356;600.8407771940439;622.2346513788066;624.1137584629837;646.6346514219451;670.8893032649655;671.2750229751856;7660.655270512841;8646.265067469336;8916.420432671985;8986.595603197871;9093.4998575079;528.3685995235656;658.1608449227178;661.4245606322434;663.6714826160985;665.9733610655617;3874.593167717349;4269.188854117708;4403.9779801100785;4447.510773814878;4453.265211240109;111719.32421013691;113168.86831131583;113996;116454.8354516444;119570;72459;80583;92553.5372323134;101780.49109754404;104017;74778.5044299111;75633;80569;82412;85890.69929055976;7687.615619218905;7878.4091193161885;9053.411528250643;9477.952610236905;9531.47576883278;40038.39942400924;42919.57080429156;48102.518974809806;53763.73118134384;54959.900801984535;69354.3064569368;73466.16334591678;74895.62552187205;75528.24471755212;78342;12185.329806860707;12235.87764122383;12327.69180770488;12429.378531073591;12605.916456072326;13708.93145534266;13783.104098233583;13921.373538191008;14055.859441405455;14058.367373468423;10895.182861285593;11836.881631183578;12034.338111403957;12976.286304253357;13095.41070651842;12256.693582660148;12381;12489.313087779896;12712.936435317764;12902.354882256037;12341.876581234073;12575.622731318075;12603.810942836048;12640.051996100514;12897.613071607866;10553.63062292816;10836.403997780199;11181;11308.886911130783;11347.48936297852;10283.94858025735;11125.610603628835;11185.105191584491;11292.43537823122;11338.263012904135 02:53:22 INFO - PROCESS | 1638 | __end_tp_report 02:53:22 INFO - PROCESS | 1638 | __start_cc_report 02:53:22 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1852 02:53:22 INFO - PROCESS | 1638 | __end_cc_report 02:53:22 INFO - PROCESS | 1638 | __startTimestamp1484650401985__endTimestamp 02:53:22 INFO - PROCESS | 1638 | 02:53:22 INFO - PROCESS | 1638 | ------- Summary: start ------- 02:53:22 INFO - PROCESS | 1638 | Number of tests: 6 02:53:22 INFO - PROCESS | 1638 | 02:53:22 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5635.15 Median:5747.40 stddev:638.35 (11.1%) stddev-sans-first:613.87 02:53:22 INFO - PROCESS | 1638 | Values: 3317.5 3340.9 3351.4 3357.8 3407.2 5563.9 5625.7 5672.0 5676.1 5689.1 5558.4 5590.5 5656.6 5661.5 5688.9 5094.6 5121.1 5141.7 5170.8 5197.7 5127.2 5131.2 5146.5 5221.5 5263.8 4814.0 5177.1 5199.7 5205.2 5205.2 5191.5 5232.4 5252.4 5254.6 5285.4 5074.4 5077.8 5166.6 5183.3 5202.0 5576.7 5594.9 5605.9 5622.2 5642.9 6108.0 6157.4 6171.2 6182.5 6202.1 5112.6 6026.4 6254.4 6273.3 6277.9 5627.5 5638.2 5668.7 5679.5 5716.8 6258.3 6301.8 6308.5 6314.4 6326.3 6067.5 6070.8 6086.1 6103.0 6111.0 4583.5 5863.4 6053.7 6135.6 6183.1 6045.8 6048.7 6049.5 6058.0 6065.9 5010.6 6077.9 6114.1 6121.8 6122.5 4824.4 4864.6 4885.3 4887.2 4917.5 4337.9 4339.7 4340.7 4373.1 4390.7 5532.3 5583.5 5717.3 5722.6 5725.3 6110.0 6126.2 6182.9 6191.9 6257.7 5615.6 5680.2 5692.4 5693.4 5702.7 5342.7 5350.7 5361.4 5361.7 5375.0 6170.4 6270.1 6280.2 6284.8 6302.1 4631.4 6125.4 6155.4 6194.9 6218.1 6181.5 6209.4 6233.5 6234.6 6237.3 6078.0 6092.0 6122.1 6147.8 6153.7 5902.4 6119.1 6128.7 6133.9 6167.6 4951.3 6044.6 6055.5 6090.4 6098.4 5959.9 6008.6 6017.9 6024.2 6041.3 5688.4 5747.4 5754.5 5854.4 5882.4 5949.9 5969.3 5971.3 6016.6 6103.8 4839.8 5837.9 5871.5 5910.3 5933.2 02:53:22 INFO - PROCESS | 1638 | 02:53:22 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:74732.91 Median:39376.41 stddev:178253.36 (452.7%) stddev-sans-first:178666.29 02:53:22 INFO - PROCESS | 1638 | Values: 506.6 518.9 526.9 537.3 541.7 30346.4 38642.8 40033.8 40112.6 40168.2 40663.4 41339.8 41785.0 41902.0 41951.8 9305.2 9495.2 9500.7 9512.0 9517.0 9333.4 9425.0 9435.7 9442.0 9442.7 9412.3 9421.1 9447.8 9471.1 9538.8 9386.8 9436.7 9443.5 9446.8 9453.8 9287.2 9371.0 9375.3 9377.1 9381.5 39247.2 39505.6 39518.6 39534.4 39584.8 3121.8 3243.4 3264.2 3287.9 3293.4 29338.0 29986.0 30061.4 30244.7 30568.7 3143.5 3182.6 3195.6 3195.9 3277.6 478758.0 479341.0 483849.0 485793.0 496579.0 33062.8 59553.5 59809.0 59936.7 60068.7 34041.5 34622.7 35026.5 35090.6 35129.5 14375.4 14527.4 14527.5 14545.3 14551.3 12272.1 12331.4 12350.4 12354.9 12381.4 7698.3 7711.8 7788.1 7799.1 7816.9 3166.1 3172.1 3216.2 3227.5 3267.0 858.3 883.0 903.2 956.0 1076.0 28320.6 29397.3 29859.9 30006.8 30401.5 719.2 878.8 979.8 1009.6 1017.3 12881.3 13568.9 15099.1 15437.9 15438.5 656681.0 876949.0 887649.0 888509.0 891517.0 58663.7 59316.4 59437.0 59444.0 59521.1 1193.1 1231.4 1231.8 1327.8 1354.0 24404.6 30397.0 30990.9 31530.2 32295.7 54095.2 54693.2 54772.9 54844.5 54921.7 595947.0 600960.0 601532.0 601709.0 603426.0 26238.6 26604.2 26859.2 26891.7 27025.6 44246.0 45462.0 45891.0 46375.8 46582.8 37093.0 38428.8 38678.0 38947.6 39555.6 37033.1 37358.4 37851.4 37961.0 39199.2 31660.5 33547.8 36718.1 38011.6 38149.4 31366.6 33573.8 33690.2 34139.5 34403.5 25199.5 25315.0 25346.2 25607.1 25899.4 02:53:22 INFO - PROCESS | 1638 | 02:53:22 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:37269.97 Median:36142.46 stddev:100639.69 (278.5%) stddev-sans-first:100883.87 02:53:22 INFO - PROCESS | 1638 | Values: 368.6 369.4 382.1 384.7 400.6 18354.8 19135.0 19413.2 19567.1 19764.5 19779.6 20128.7 20172.9 20261.7 20658.7 5583.7 5689.9 5863.6 5957.2 5974.3 3858.8 5909.9 5946.7 5951.2 5957.2 4072.7 4084.9 7258.8 7606.7 7682.4 7550.2 7569.2 7720.7 7891.6 7992.2 7425.4 7722.5 7737.5 7764.1 7800.6 20671.7 26342.3 26619.7 26880.0 27279.8 2212.6 2546.3 2574.8 2779.3 3186.6 15274.5 15679.9 16622.9 16730.0 17610.9 1837.3 2022.8 2027.1 2068.9 2073.2 135888.6 136683.0 143396.3 150179.2 151663.2 17294.9 21261.7 22229.0 22238.3 22396.7 36139.1 36145.8 36903.8 36963.6 36965.6 10789.5 10874.4 10880.9 10966.7 11162.6 9000.8 9007.0 9015.1 9020.9 9164.1 8058.0 9631.1 9708.6 9898.2 9913.2 2961.8 3581.7 3675.7 3688.0 3695.7 829.3 939.6 949.8 958.2 987.5 19417.7 19799.0 20802.5 20945.0 20951.4 753.7 904.2 917.0 917.2 920.2 10439.4 10988.9 11004.5 11029.6 11061.6 584584.0 593721.0 600625.0 608131.0 609559.0 127209.4 128318.0 130867.0 135913.0 136701.0 947.9 949.8 956.8 966.8 969.4 17101.5 17938.9 18424.5 18527.2 18580.0 50490.4 54767.7 55479.4 55541.2 55633.7 79990.0 80815.6 82867.2 83093.0 83376.3 5672.5 7293.6 7391.6 7421.7 8055.2 10002.6 10429.4 11893.8 12230.4 12475.5 10470.8 10484.5 10521.8 10546.0 10997.1 9961.7 10510.1 10699.9 10816.6 10978.5 10838.7 10872.8 11087.1 11241.5 11313.9 7161.0 7303.9 7340.5 7395.9 7567.8 8346.3 10229.8 10735.9 10806.0 11140.7 02:53:22 INFO - PROCESS | 1638 | 02:53:22 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5377.82 Median:4970.54 stddev:2959.40 (59.5%) stddev-sans-first:2953.10 02:53:22 INFO - PROCESS | 1638 | Values: 1466.0 1486.3 1654.9 1801.5 1848.7 8012.7 8445.7 8452.1 8462.2 8468.7 6564.7 7429.6 7663.1 7681.2 8172.1 2301.6 2346.0 2348.7 2350.0 2352.7 2296.7 2305.7 2310.5 2348.7 2360.9 2311.3 2322.5 2346.8 2347.9 2351.6 1941.4 2304.2 2327.2 2327.2 2335.8 2323.3 2354.7 2355.7 2359.4 2360.6 6945.6 8284.8 8343.4 8345.2 8346.0 5011.9 5143.5 5172.4 5181.1 5194.4 3192.5 3270.1 3488.1 3526.8 3545.3 937.6 1032.7 1062.1 1063.2 1072.0 10452.5 10756.2 10782.7 10791.9 10888.0 4179.9 4302.6 4364.4 4482.1 4500.7 8503.0 8510.2 8512.1 8524.5 8542.7 4440.7 4931.7 4939.0 4940.9 4953.7 4224.5 4281.3 4455.0 4645.6 4731.4 3509.9 3560.9 3613.7 3639.9 3672.1 1069.7 1086.9 1091.7 1101.0 1101.5 880.8 887.1 887.5 907.3 907.6 5438.2 5698.9 5799.8 5857.7 5869.8 871.8 893.8 897.2 919.5 971.2 3307.1 3747.5 3750.8 3854.4 3914.3 9885.3 10048.8 10308.6 10319.3 10335.0 10267.2 10270.8 10271.0 10276.8 10309.3 7759.0 7760.5 7760.7 7850.3 7877.7 5352.4 5476.3 5594.6 5646.4 5753.0 9315.4 9398.5 9536.0 9539.4 9545.8 9331.5 9368.3 9465.8 9737.1 9770.0 6243.3 6477.8 6481.8 6732.1 6853.6 7683.0 7868.9 7974.5 8052.2 8070.7 7050.3 7130.5 7170.7 7237.2 7303.7 6808.1 6983.1 7079.8 7102.5 7189.3 6625.6 6646.4 6747.5 6754.2 6755.7 4889.4 4896.6 4909.0 4915.0 4940.0 4494.8 4846.3 4872.5 4987.4 4996.6 02:53:22 INFO - PROCESS | 1638 | 02:53:22 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4203.70 Median:4719.93 stddev:1259.77 (26.7%) stddev-sans-first:1228.05 02:53:22 INFO - PROCESS | 1638 | Values: 260.9 299.6 302.6 309.5 313.2 4408.9 4699.4 4774.8 4850.0 5126.2 4763.5 4874.5 4915.7 4920.8 5089.7 3868.9 3894.8 3895.5 3921.8 3933.2 3504.1 3607.4 3901.7 3920.5 3948.5 3000.3 3205.5 3382.8 3873.6 3891.3 3074.0 3397.4 3472.8 3789.2 3813.8 3338.3 3339.6 3344.5 3346.5 3355.6 4493.0 4894.4 4900.6 4928.3 4930.5 3385.0 3565.9 4061.2 4321.4 4364.0 4837.3 5211.4 5236.7 5284.8 5304.0 3624.6 3648.5 3654.4 3655.9 3684.2 4503.5 5188.9 5270.1 5580.2 5585.3 3809.9 3853.1 3853.5 3853.9 3874.8 3931.4 3934.4 3934.8 3939.9 3944.8 4231.4 4458.0 4468.5 4520.8 4549.0 5098.5 5324.4 5346.8 5356.6 5414.4 1252.3 1268.9 1274.5 1284.4 1290.5 834.1 852.7 853.3 853.9 856.2 4578.0 4817.9 5032.5 5053.4 5060.7 4717.9 5366.0 5478.1 5506.7 5538.8 3788.3 4114.0 4824.9 4848.0 5000.3 2688.1 2707.3 2715.9 2733.7 2734.7 4739.5 4762.0 5353.6 5386.3 5387.5 4513.8 4846.7 5107.6 5348.9 5355.4 4414.8 4938.2 5133.4 5281.2 5382.7 4721.9 5136.8 5138.8 5173.6 5193.1 4267.5 4560.0 4853.3 5147.0 5186.9 5331.3 5354.5 5362.7 5379.1 5416.3 3093.6 3392.5 3592.0 3594.4 3640.0 4960.5 4985.9 5072.9 5114.7 5256.4 4356.2 4941.8 4990.6 5009.4 5016.0 4085.4 4326.5 4569.7 4613.2 4831.2 4337.0 4562.6 4620.0 4970.8 5227.3 4468.4 5148.8 5248.4 5275.1 5339.1 5213.3 5216.6 5232.8 5248.4 5270.6 02:53:22 INFO - PROCESS | 1638 | 02:53:22 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20113.06 Median:4208.07 stddev:29849.60 (709.3%) stddev-sans-first:29897.68 02:53:22 INFO - PROCESS | 1638 | Values: 681.9 717.2 751.8 762.4 776.8 13220.7 14461.7 14596.4 14634.3 14635.5 12383.7 12749.4 12866.7 13064.9 13296.8 807.1 816.5 821.9 822.3 823.6 644.5 669.8 671.8 671.8 673.4 706.1 833.3 853.0 856.7 858.6 846.8 847.7 847.8 848.1 849.6 504.8 627.2 627.3 627.5 628.6 11213.7 11895.9 11962.0 13031.3 13390.0 13453.5 13687.2 13780.7 13914.2 13931.0 10545.6 10821.6 10953.9 10962.6 11022.5 3603.3 3626.2 3633.2 3698.7 3709.0 85031.6 86937.1 88376.6 93272.5 93299.5 10295.7 10371.6 10449.2 10498.1 10498.4 19953.5 19998.0 20139.6 20152.7 20197.0 7299.5 7471.9 7665.7 7678.0 7744.9 4139.2 4147.0 4306.4 4375.9 4441.6 3384.5 3449.5 3455.1 3495.3 3499.9 584.8 586.2 587.1 591.2 600.8 622.2 624.1 646.6 670.9 671.3 7660.7 8646.3 8916.4 8986.6 9093.5 528.4 658.2 661.4 663.7 666.0 3874.6 4269.2 4404.0 4447.5 4453.3 111719.3 113168.9 113996.0 116454.8 119570.0 72459.0 80583.0 92553.5 101780.5 104017.0 74778.5 75633.0 80569.0 82412.0 85890.7 7687.6 7878.4 9053.4 9478.0 9531.5 40038.4 42919.6 48102.5 53763.7 54959.9 69354.3 73466.2 74895.6 75528.2 78342.0 12185.3 12235.9 12327.7 12429.4 12605.9 13708.9 13783.1 13921.4 14055.9 14058.4 10895.2 11836.9 12034.3 12976.3 13095.4 12256.7 12381.0 12489.3 12712.9 12902.4 12341.9 12575.6 12603.8 12640.1 12897.6 10553.6 10836.4 11181.0 11308.9 11347.5 10283.9 11125.6 11185.1 11292.4 11338.3 02:53:22 INFO - PROCESS | 1638 | -------- Summary: end -------- 02:53:22 INFO - PROCESS | 1638 | 02:53:22 INFO - TEST-INFO | 1638: exit 0 02:53:22 INFO - TEST-OK | dromaeo_css | took 1119627ms 02:53:22 INFO - TEST-START | kraken 02:53:22 INFO - operating with platform_type : mac_ 02:53:22 INFO - Initialising browser for kraken test... 02:53:22 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpAzrqpy/profile http://localhost:49241/getInfo.html) 02:53:25 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 02:53:25 INFO - PROCESS | 1647 | colorDepth:24 02:53:25 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 02:53:25 INFO - PROCESS | 1647 | __metrics 02:53:25 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" 02:53:25 INFO - PROCESS | 1647 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:53:26 INFO - TEST-INFO | 1647: exit 0 02:53:26 INFO - Browser initialized. 02:53:26 INFO - Running cycle 1/1 for kraken test... 02:53:26 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpAzrqpy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:38 INFO - PROCESS | 1649 | RSS: Main: 222158848 02:53:38 INFO - PROCESS | 1649 | 02:53:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 02:53:42 INFO - PROCESS | 1649 | RSS: Main: 271904768 02:53:42 INFO - PROCESS | 1649 | 02:53:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 02:53:45 INFO - PROCESS | 1649 | RSS: Main: 283156480 02:53:45 INFO - PROCESS | 1649 | 02:53:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 02:53:49 INFO - PROCESS | 1649 | RSS: Main: 379760640 02:53:49 INFO - PROCESS | 1649 | 02:53:51 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 02:53:51 INFO - PROCESS | 1649 | RSS: Main: 283631616 02:53:51 INFO - PROCESS | 1649 | 02:53:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:53:54 INFO - PROCESS | 1649 | RSS: Main: 284987392 02:53:54 INFO - PROCESS | 1649 | 02:53:57 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 02:53:57 INFO - PROCESS | 1649 | RSS: Main: 324927488 02:53:57 INFO - PROCESS | 1649 | 02:54:00 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 02:54:01 INFO - PROCESS | 1649 | RSS: Main: 326615040 02:54:01 INFO - PROCESS | 1649 | 02:54:04 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 02:54:04 INFO - PROCESS | 1649 | RSS: Main: 323874816 02:54:04 INFO - PROCESS | 1649 | 02:54:06 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:54:07 INFO - PROCESS | 1649 | RSS: Main: 298672128 02:54:07 INFO - PROCESS | 1649 | 02:54:08 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:54:09 INFO - PROCESS | 1649 | RSS: Main: 299409408 02:54:09 INFO - PROCESS | 1649 | 02:54:11 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:54:12 INFO - PROCESS | 1649 | RSS: Main: 302362624 02:54:12 INFO - PROCESS | 1649 | 02:54:15 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:54:16 INFO - PROCESS | 1649 | RSS: Main: 322850816 02:54:16 INFO - PROCESS | 1649 | 02:54:18 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:54:19 INFO - PROCESS | 1649 | RSS: Main: 316239872 02:54:19 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 02:54:21 INFO - PROCESS | 1649 | RSS: Main: 360087552 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | __start_tp_report 02:54:21 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 02:54:21 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 02:54:21 INFO - PROCESS | 1649 | |i|pagename|runs| 02:54:21 INFO - PROCESS | 1649 | |0;ai-astar;115;112;113;115;114;114;113;113;113;115 02:54:21 INFO - PROCESS | 1649 | |1;audio-beat-detection;149;138;140;142;111;110;108;109;141;111 02:54:21 INFO - PROCESS | 1649 | |2;audio-dft;186;183;186;183;182;184;185;184;183;184 02:54:21 INFO - PROCESS | 1649 | |3;audio-fft;82;59;58;90;59;58;58;58;79;58 02:54:21 INFO - PROCESS | 1649 | |4;audio-oscillator;87;70;95;69;68;69;90;68;68;92 02:54:21 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;88;85;90;87;89;88;89;71;132;130 02:54:21 INFO - PROCESS | 1649 | |6;imaging-darkroom;132;149;95;94;93;94;94;94;94;94 02:54:21 INFO - PROCESS | 1649 | |7;imaging-desaturate;81;81;92;128;128;84;84;84;83;81 02:54:21 INFO - PROCESS | 1649 | |8;json-parse-financial;54;53;56;53;56;58;57;56;56;56 02:54:21 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;65;74;67;75;75;69;69;70;69;71 02:54:21 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;84;86;85;84;83;83;84;82;97;108 02:54:21 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;141;140;140;140;146;146;148;141;182;186 02:54:21 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;220;173;172;173;170;172;169;173;183;170 02:54:21 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;69;68;70;68;68;70;66;68;68;68 02:54:21 INFO - PROCESS | 1649 | __end_tp_report 02:54:21 INFO - PROCESS | 1649 | __start_cc_report 02:54:21 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1939 02:54:21 INFO - PROCESS | 1649 | __end_cc_report 02:54:21 INFO - PROCESS | 1649 | __startTimestamp1484650461593__endTimestamp 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | ------- Summary: start ------- 02:54:21 INFO - PROCESS | 1649 | Number of tests: 14 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.06 (0.9%) stddev-sans-first:1.01 02:54:21 INFO - PROCESS | 1649 | Values: 115.0 112.0 113.0 115.0 114.0 114.0 113.0 113.0 113.0 115.0 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:125.90 Median:139.00 stddev:17.22 (12.4%) stddev-sans-first:16.11 02:54:21 INFO - PROCESS | 1649 | Values: 149.0 138.0 140.0 142.0 111.0 110.0 108.0 109.0 141.0 111.0 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:1.33 (0.7%) stddev-sans-first:1.20 02:54:21 INFO - PROCESS | 1649 | Values: 186.0 183.0 186.0 183.0 182.0 184.0 185.0 184.0 183.0 184.0 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:65.90 Median:59.00 stddev:12.56 (21.3%) stddev-sans-first:11.89 02:54:21 INFO - PROCESS | 1649 | Values: 82.0 59.0 58.0 90.0 59.0 58.0 58.0 58.0 79.0 58.0 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.50 stddev:11.71 (14.9%) stddev-sans-first:11.92 02:54:21 INFO - PROCESS | 1649 | Values: 87.0 70.0 95.0 69.0 68.0 69.0 90.0 68.0 68.0 92.0 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:94.90 Median:88.00 stddev:19.80 (22.5%) stddev-sans-first:20.84 02:54:21 INFO - PROCESS | 1649 | Values: 88.0 85.0 90.0 87.0 89.0 88.0 89.0 71.0 132.0 130.0 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:103.30 Median:94.00 stddev:20.02 (21.3%) stddev-sans-first:18.34 02:54:21 INFO - PROCESS | 1649 | Values: 132.0 149.0 95.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:92.60 Median:83.50 stddev:18.93 (22.7%) stddev-sans-first:19.61 02:54:21 INFO - PROCESS | 1649 | Values: 81.0 81.0 92.0 128.0 128.0 84.0 84.0 84.0 83.0 81.0 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.65 (2.9%) stddev-sans-first:1.66 02:54:21 INFO - PROCESS | 1649 | Values: 54.0 53.0 56.0 53.0 56.0 58.0 57.0 56.0 56.0 56.0 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.50 stddev:3.37 (4.8%) stddev-sans-first:2.96 02:54:21 INFO - PROCESS | 1649 | Values: 65.0 74.0 67.0 75.0 75.0 69.0 69.0 70.0 69.0 71.0 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:84.00 stddev:8.34 (9.9%) stddev-sans-first:8.75 02:54:21 INFO - PROCESS | 1649 | Values: 84.0 86.0 85.0 84.0 83.0 83.0 84.0 82.0 97.0 108.0 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:151.00 Median:146.00 stddev:17.66 (12.1%) stddev-sans-first:18.36 02:54:21 INFO - PROCESS | 1649 | Values: 141.0 140.0 140.0 140.0 146.0 146.0 148.0 141.0 182.0 186.0 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:173.00 stddev:15.43 (8.9%) stddev-sans-first:4.12 02:54:21 INFO - PROCESS | 1649 | Values: 220.0 173.0 172.0 173.0 170.0 172.0 169.0 173.0 183.0 170.0 02:54:21 INFO - PROCESS | 1649 | 02:54:21 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 02:54:21 INFO - PROCESS | 1649 | Values: 69.0 68.0 70.0 68.0 68.0 70.0 66.0 68.0 68.0 68.0 02:54:21 INFO - PROCESS | 1649 | -------- Summary: end -------- 02:54:21 INFO - PROCESS | 1649 | 02:54:22 INFO - TEST-INFO | 1649: exit 0 02:54:22 INFO - TEST-OK | kraken | took 60009ms 02:54:22 INFO - SUITE-END | took 1179s 02:54:22 INFO - Completed test suite (00:19:39) 02:54:22 INFO - javascript benchmark 02:54:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.452620317648, 3340.8830690925824, 3351.4302568563344, 3357.832108394581, 3407.2163402417445, 5563.888722225558, 5625.746841392137, 5672.0, 5676.063449530828, 5689.089745640704, 5558.416366281543, 5590.488508606107, 5656.575756818244, 5661.46216109469, 5688.857778555538, 5094.617903657222, 5121.078205922932, 5141.742912854361, 5170.793168273283, 5197.66215196011, 5127.179651255799, 5131.204663277198, 5146.536811686948, 5221.530062294392, 5263.789448422078, 4813.975930120345, 5177.068127737006, 5199.740012999335, 5205.16717325228, 5205.193195054753, 5191.480851914835, 5232.398274198478, 5252.395974462909, 5254.632175747699, 5285.4450282720145, 5074.3657042869645, 5077.822276220351, 5166.560842328407, 5183.2743415921805, 5201.973990130063, 5576.665400076008, 5594.888102237973, 5605.934872374236, 5622.156676498517, 5642.915356269659, 6108.0, 6157.415045570664, 6171.197744293213, 6182.5363097767395, 6202.131701561785, 5112.565431938289, 6026.397360263939, 6254.437100660963, 6273.341299163568, 6277.905831412532, 5627.493525582676, 5638.23883775685, 5668.688222147739, 5679.545636349082, 5716.771329146871, 6258.311585725566, 6301.779437719658, 6308.495320374359, 6314.368563143649, 6326.272478665012, 6067.514598832083, 6070.757169713162, 6086.147939288503, 6103.0, 6111.0, 4583.518730533313, 5863.384344643751, 6053.727582258721, 6135.570510064253, 6183.134361189437, 6045.8488537786025, 6048.727807248684, 6049.5462840287155, 6057.969710151421, 6065.909011364833, 5010.574101201366, 6077.908831367533, 6114.0828875669, 6121.785737499255, 6122.54080943931, 4824.372831531879, 4864.610831133501, 4885.267209918469, 4887.193613053877, 4917.532834380728, 4337.869863904088, 4339.717918335298, 4340.674449416307, 4373.081652852937, 4390.692651514363, 5532.30846144232, 5583.497485226268, 5717.256756621613, 5722.62802917809, 5725.31296244445, 6109.9816581254145, 6126.242866754769, 6182.876342473125, 6191.907121393183, 6257.687115644199, 5615.578831587565, 5680.176374425685, 5692.373838877803, 5693.402192769782, 5702.657840529581, 5342.652727572696, 5350.705711185922, 5361.437049109787, 5361.651492652965, 5375.0, 6170.413810687977, 6270.059491076375, 6280.152179455715, 6284.811455656338, 6302.086197501429, 4631.421072365954, 6125.418593525838, 6155.384461553809, 6194.907076393948, 6218.129461875432, 6181.474574661204, 6209.441150296495, 6233.532485063729, 6234.594751341148, 6237.345078766664, 6078.0, 6092.0, 6122.142899994094, 6147.815565533041, 6153.692315384303, 5902.350741418526, 6119.106526814713, 6128.655903792346, 6133.854967165127, 6167.599106058092, 4951.257311403318, 6044.576879618385, 6055.515558755377, 6090.3605121461605, 6098.390160984043, 5959.851003724942, 6008.579399441997, 6017.879642407215, 6024.156618073385, 6041.335453100068, 5688.40271771458, 5747.396523364986, 5754.510866576388, 5854.385289544707, 5882.411758824083, 5949.869524790449, 5969.283685957713, 5971.313298970674, 6016.578839481194, 6103.84740381494, 4839.782209800497, 5837.919984802825, 5871.530277577869, 5910.320313163869, 5933.199018132497], "value": 5597.471072746246, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.6200349737697, 518.9377274727032, 526.9420363759983, 537.2505355029733, 541.6587549843598, 30346.393072138544, 38642.806785966066, 40033.799831000804, 40112.59887401125, 40168.19663606726, 40663.39004914921, 41339.79330103345, 41785.0, 41902.0, 41951.79024104875, 9305.162535371815, 9495.240380769523, 9500.71497855062, 9512.0, 9516.952415237914, 9333.439993600407, 9425.0, 9435.716928492122, 9441.961384247727, 9442.669506567272, 9412.294077944147, 9421.057894210559, 9447.763805904839, 9471.147596716293, 9538.761530961712, 9386.765330866749, 9436.716898493056, 9443.527823608862, 9446.763830904283, 9453.810923781486, 9287.210587100104, 9371.0, 9375.296852736004, 9377.062293770636, 9381.5309234538, 39247.21505569901, 39505.60494395077, 39518.60481395178, 39534.406983895264, 39584.802075989726, 3121.750259979196, 3243.4486137356707, 3264.2329052672603, 3287.852046657906, 3293.4071867063917, 29337.973170938916, 29986.0, 30061.413863694062, 30244.69755302441, 30568.69431305703, 3143.528470729386, 3182.633997090341, 3195.6325022622464, 3195.9360812783616, 3277.573915390984, 478758.0, 479341.0, 483849.0, 485793.0, 496579.0, 33062.842800501865, 59553.51116222129, 59809.0, 59936.70031649901, 60068.699656501434, 34041.48937765935, 34622.65377346244, 35026.474602880975, 35090.64909350925, 35129.47305790415, 14375.353109110116, 14527.418903243963, 14527.491537796337, 14545.345459454138, 14551.345189466289, 12272.079594030483, 12331.445084971198, 12350.44423000967, 12354.876451235552, 12381.380930953417, 7698.2686644768655, 7711.768646940601, 7788.14330423653, 7799.103103143211, 7816.921830781733, 3166.1293144385477, 3172.1435212492497, 3216.212028053142, 3227.5320078588475, 3266.9673303267136, 858.2704701004096, 882.969096081634, 903.1826197291462, 955.9713208603614, 1075.9515821788038, 28320.575191372147, 29397.251670978098, 29859.850700746792, 30006.849965750032, 30401.543976840367, 719.1909102259957, 878.8198419324151, 979.7997453119871, 1009.6369900634086, 1017.3285631483186, 12881.291528965809, 13568.93215533916, 15099.094054356774, 15437.922810385877, 15438.5368438947, 656681.0, 876949.0, 887649.0, 888509.0, 891517.0, 58663.70668146632, 59316.40683593195, 59437.0, 59444.0, 59521.10718339228, 1193.1111322065117, 1231.3658465889894, 1231.7967535356925, 1327.82074419954, 1353.986460135386, 24404.6339304907, 30397.0, 30990.915317964664, 31530.211744706565, 32295.67704322927, 54095.188572172236, 54693.179602306795, 54772.90454190974, 54844.45155548393, 54921.72539137279, 595947.0, 600960.0, 601532.0, 601709.0, 603426.0, 26238.60642090332, 26604.201873943814, 26859.194224173305, 26891.731082688922, 27025.59461608038, 44246.0, 45462.0, 45891.0, 46375.84060398517, 46582.76708616435, 37093.0, 38428.84713458601, 38678.03304917287, 38947.6105238944, 39555.60444395519, 37033.074173145884, 37358.439623406215, 37851.432228517144, 37961.0, 39199.216015678954, 31660.5250921241, 33547.83226083854, 36718.082047949014, 38011.619883800806, 38149.427758583086, 31366.58850351694, 33573.83213083919, 33690.157746056546, 34139.4879076819, 34403.483947741304, 25199.49601007933, 25315.0, 25346.239612811645, 25607.103751368613, 25899.352516187246], "value": 18463.60020641314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.59638695628286, 369.3665363900911, 382.1287464580755, 384.66341950793054, 400.555383524288, 18354.81645183548, 19135.043247837606, 19413.223471061177, 19567.119479623434, 19764.505887352825, 19779.60440791187, 20128.698069528968, 20172.899135504304, 20261.696074558895, 20658.69011964818, 5583.6928968906695, 5689.8577535561635, 5863.648181109147, 5957.225560677106, 5974.253218347707, 3858.8070596470207, 5909.852253693671, 5946.672932988684, 5951.22634057574, 5957.165996760457, 4072.735272207312, 4084.9183016339657, 7258.782236532912, 7606.695732170734, 7682.385409167281, 7550.207228241065, 7569.205233450491, 7720.691172353099, 7891.644875980594, 7992.160823113606, 7425.405967522585, 7722.536647801094, 7737.4970626909635, 7764.107127680276, 7800.609969501502, 20671.689924651142, 26342.341441464116, 26619.733802661918, 26880.0, 27279.772410241585, 2212.5906707259046, 2546.312495626189, 2574.845509269431, 2779.332960089584, 3186.5698130752285, 15274.474856147137, 15679.92160039204, 16622.916885415496, 16729.996200228026, 17610.91194544032, 1837.2926423326983, 2022.787607301227, 2027.0574183004974, 2068.9482762930897, 2073.2121793718443, 135888.6411135886, 136683.0, 143396.28301858425, 150179.24910375488, 151663.24168379197, 17294.90908727441, 21261.68107478389, 22229.0, 22238.332850014525, 22396.664050039264, 36139.09652258662, 36145.81927090348, 36903.81548092242, 36963.63036369602, 36965.63034369676, 10789.514471848786, 10874.401907894984, 10880.891191088147, 10966.725831854268, 11162.609308674157, 9000.774980625536, 9006.954965225132, 9015.14356136166, 9020.881487578152, 9164.083591640783, 8058.0, 9631.08504692053, 9708.611655533841, 9898.158656514133, 9913.206943444507, 2961.763058955278, 3581.6690477855323, 3675.6875665568728, 3687.9815600921825, 3695.74129810916, 829.2578142562373, 939.6147579492375, 949.8337790886567, 958.2046901072093, 987.4717026390847, 19417.708734368996, 19799.0, 20802.47993800137, 20945.0, 20951.371458856258, 753.6570860258569, 904.1546154345708, 916.9587368568431, 917.2111983694151, 920.1580553793337, 10439.37363758177, 10988.945055274673, 11004.504797284142, 11029.61396351124, 11061.612843550438, 584584.0, 593721.0, 600625.0, 608131.0, 609559.0, 127209.36395317964, 128318.0, 130867.0, 135913.0, 136701.0, 947.8862536495665, 949.8100379924043, 956.8038552096804, 966.7728083900278, 969.3989726369555, 17101.48695539136, 17938.91030544839, 18424.539386515444, 18527.166277517274, 18580.0, 50490.39701662692, 54767.72616136894, 55479.445205547425, 55541.1668824976, 55633.72183139058, 79990.0, 80815.57553273412, 82867.17132828594, 83093.0, 83376.33247334899, 5672.4894759471845, 7293.635318234174, 7391.630418478947, 7421.740239091606, 8055.1944805521325, 10002.649907253211, 10429.374237545771, 11893.821592675944, 12230.388480575757, 12475.500979961063, 10470.842937356098, 10484.528196231035, 10521.842172367573, 10546.0, 10997.12023038171, 9961.701148965543, 10510.054095131474, 10699.89804907493, 10816.566272588605, 10978.451077446256, 10838.67483975482, 10872.782544348911, 11087.05760010408, 11241.49413276388, 11313.943430282796, 7160.99746035545, 7303.926960730325, 7340.486165968545, 7395.852082958203, 7567.848643027219, 8346.332293416634, 10229.84655230187, 10735.94632026835, 10806.0, 11140.721481963015], "value": 10720.130149964532, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.9853401465984, 1486.346007756587, 1654.925528351224, 1801.531601783536, 1848.7226915962613, 8012.719554815582, 8445.662173513067, 8452.112528184536, 8462.153784621534, 8468.70359537417, 6564.737410503574, 7429.6285185740635, 7663.118741344747, 7681.193474685161, 8172.101068882418, 2301.631738921769, 2346.0263990443946, 2348.659444380564, 2349.9647505287435, 2352.694149760529, 2296.6784650148993, 2305.723313202418, 2310.4570425949887, 2348.729896061949, 2360.9173678921243, 2311.3181611424584, 2322.535492901418, 2346.77705617966, 2347.8943447544816, 2351.6354964980455, 1941.4078705994737, 2304.1820153845397, 2327.1622216002224, 2327.2320134355623, 2335.7897789198882, 2323.314622186459, 2354.658574506704, 2355.729091154522, 2359.398353419867, 2360.634101714237, 6945.617991010492, 8284.751457456287, 8343.374246931504, 8345.165483451667, 8345.95827020861, 5011.924821127686, 5143.485651434864, 5172.405173405069, 5181.145111056671, 5194.35070616173, 3192.5211218317204, 3270.084376374619, 3488.0582242794303, 3526.770759900598, 3545.308664810363, 937.5921474158763, 1032.7211652853762, 1062.13966686983, 1063.1813503602184, 1072.0, 10452.529636166391, 10756.19328550362, 10782.73043173919, 10791.892081079168, 10888.0, 4179.874603761892, 4302.634276086567, 4364.367166760865, 4482.148391805546, 4500.684952053325, 8503.022152452424, 8510.191531804468, 8512.106228846005, 8524.531150786643, 8542.658293668184, 4440.711353761995, 4931.7040977541465, 4939.0121975605025, 4940.876478088005, 4953.653244272867, 4224.514180869178, 4281.250781113293, 4454.955450445519, 4645.605123564535, 4731.361266229083, 3509.894703158909, 3560.8753693620597, 3613.728970327236, 3639.94540081899, 3672.06362377592, 1069.7058308965097, 1086.9347839129518, 1091.6506717850211, 1100.9889901101046, 1101.54285971321, 880.8282384935004, 887.1350433327455, 887.5207388010402, 907.3240435875183, 907.6233363154349, 5438.15708565173, 5698.914516282259, 5799.768009279582, 5857.736401861926, 5869.7945571904775, 871.7646235516376, 893.8167675626481, 897.210454799772, 919.4529255093208, 971.2278738402987, 3307.107081088093, 3747.5315585551807, 3750.774953502799, 3854.383298672199, 3914.256291304643, 9885.25860560461, 10048.799024019625, 10308.639197628198, 10319.329243599143, 10335.0, 10267.229957753198, 10270.845937310947, 10271.024252695983, 10276.794464110675, 10309.329893556895, 7759.0, 7760.456768026184, 7760.728374506865, 7850.332721718718, 7877.724279650185, 5352.384475785335, 5476.315460567429, 5594.552435805207, 5646.3788983212635, 5753.0, 9315.441073535609, 9398.530073496435, 9536.0, 9539.379940303857, 9545.809083818423, 9331.529849815217, 9368.297377696836, 9465.763355916157, 9737.07497787709, 9770.0, 6243.313235544178, 6477.77327793525, 6481.773137940149, 6732.057511948429, 6853.554518956252, 7683.0, 7868.8819667706175, 7974.5215287082965, 8052.235037671412, 8070.677172913018, 7050.25972272904, 7130.500864939404, 7170.677319520739, 7237.240089790496, 7303.671334789841, 6808.114945057111, 6983.087291079717, 7079.752208672672, 7102.5028248022145, 7189.2810718927685, 6625.635590042594, 6646.4350530205475, 6747.460203183831, 6754.155730533684, 6755.662216889037, 4889.364382630235, 4896.608271338213, 4908.9754551227015, 4915.0, 4940.011997600423, 4494.808875648021, 4846.273059041172, 4872.4883887192755, 4987.426445958616, 4996.550310471929], "value": 4356.914286057158, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [260.9099860548111, 299.60601808621675, 302.56581805109664, 309.4723496438572, 313.1904028087394, 4408.889777755549, 4699.38907941968, 4774.785134668944, 4849.975750121249, 5126.205438157087, 4763.499162939458, 4874.512548745124, 4915.655904086715, 4920.80316787329, 5089.720065396402, 3868.936042588283, 3894.7663140211534, 3895.4935858338376, 3921.8234529641136, 3933.2133573285314, 3504.141485336096, 3607.4408466687705, 3901.726879118463, 3920.470736450571, 3948.506436695413, 3000.294930691286, 3205.4710972689477, 3382.7632065755283, 3873.612638736118, 3891.299566078105, 3074.0, 3397.4394224952975, 3472.774269672463, 3789.1663833956486, 3813.80930953454, 3338.315645292709, 3339.6493368196475, 3344.5484859543894, 3346.4901324006996, 3355.580552430946, 4492.977535112336, 4894.437139728905, 4900.607951363882, 4928.33467481889, 4930.457649658535, 3385.0014245797547, 3565.94651080234, 4061.208064427438, 4321.395004699345, 4363.978180109111, 4837.298591704183, 5211.42674305826, 5236.6857988520815, 5284.841454756363, 5304.0, 3624.6194149614175, 3648.543932008499, 3654.3604869147794, 3655.9268814623824, 3684.244729830378, 4503.482099558527, 5188.896222075613, 5270.075108314883, 5580.218769372291, 5585.301837270341, 3809.904752381213, 3853.094522787143, 3853.5183102112237, 3853.8651147210276, 3874.767513949172, 3931.3906344516645, 3934.449177115206, 3934.803259836997, 3939.92120157601, 3944.8027598619956, 4231.434369283324, 4457.977710111429, 4468.463784345834, 4520.756791882259, 4548.977255113769, 5098.546914129455, 5324.361076670824, 5346.786128554814, 5356.598255130881, 5414.35027796667, 1252.311228824143, 1268.9428975696117, 1274.49020391844, 1284.4027527199896, 1290.5031562848371, 834.0616806093145, 852.7484392104344, 853.317346123099, 853.8804567360575, 856.2122846980793, 4578.0, 4817.879553011203, 5032.547070763649, 5053.36832895888, 5060.7216603086445, 4717.9292310615365, 5365.95363904035, 5478.082671065095, 5506.724663766796, 5538.75075621598, 3788.337041017811, 4113.958860411418, 4824.917357825816, 4848.0, 5000.2749601307605, 2688.0994866719475, 2707.2555047362134, 2715.9049433269743, 2733.671959364849, 2734.6991830898587, 4739.478657347689, 4762.0, 5353.598480114007, 5386.326709161355, 5387.542058924957, 4513.75174365413, 4846.660733748674, 5107.61692873036, 5348.893022139613, 5355.357357117093, 4414.757188354542, 4938.234573641092, 5133.408643320583, 5281.207818827206, 5382.650127741685, 4721.929171062368, 5136.8202112927365, 5138.76875540609, 5173.611979101507, 5193.052605273023, 4267.50923643785, 4559.993602814751, 4853.273693699834, 5146.9963357145, 5186.870328241824, 5331.280277162534, 5354.519562284546, 5362.65142765719, 5379.1393377059485, 5416.322959630046, 3093.6287645482685, 3392.508086327518, 3592.0243865874186, 3594.4248920172645, 3639.9636003639625, 4960.454350021567, 4985.900281994413, 5072.923906141337, 5114.695752583068, 5256.448072952285, 4356.208171011862, 4941.77762000718, 4990.5508504234795, 5009.416384008591, 5016.021875734343, 4085.3871919212356, 4326.459192600925, 4569.680122391401, 4613.192691278946, 4831.236598641541, 4337.0, 4562.612177964777, 4619.983603607201, 4970.801167953386, 5227.320448341691, 4468.352088947149, 5148.794048238028, 5248.370195576403, 5275.129603615361, 5339.092354299701, 5213.296205012275, 5216.626434972154, 5232.8168514103345, 5248.448912864094, 5270.578353731616], "value": 3808.391491630256, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.8772620928232, 717.243308309733, 751.812046988253, 762.4053238473989, 776.8174478997438, 13220.669483262911, 14461.710765784692, 14596.394396616364, 14634.341454634541, 14635.487757928475, 12383.69040773981, 12749.362531873416, 12866.742665146692, 13064.93467532661, 13296.800547991788, 807.1323327423029, 816.5060138616141, 821.9424640275183, 822.3462347433774, 823.5717426937989, 644.5294934697673, 669.8492839111185, 671.7816709569385, 671.8186089755764, 673.3502170405558, 706.1279320039747, 833.2667252817512, 853.0019876744193, 856.6873091321654, 858.5750053723416, 846.8052347960004, 847.7117779954783, 847.7626264645909, 848.084069205263, 849.6091797773032, 504.8485454363676, 627.2191122053027, 627.2786295759867, 627.5011365964069, 628.6228263042138, 11213.66359009231, 11895.94052029743, 11962.043036557141, 13031.283279419627, 13390.0, 13453.461861525528, 13687.24720140392, 13780.724385512234, 13914.165150091027, 13931.0, 10545.578176872916, 10821.621243256448, 10953.945230273797, 10962.616308429167, 11022.50398732059, 3603.3153700796765, 3626.184108575576, 3633.2370202257293, 3698.704103671727, 3709.0, 85031.574842126, 86937.13062869417, 88376.55811720964, 93272.53363733138, 93299.53350233274, 10295.74260643475, 10371.636992705218, 10449.164066874631, 10498.10766084876, 10498.370097794157, 19953.501162471053, 19998.0, 20139.59720805605, 20152.69770953437, 20197.0, 7299.489035767551, 7471.925280747231, 7665.731699390494, 7678.0, 7744.92255077442, 4139.19285739284, 4146.958530414718, 4306.440162778818, 4375.868723938287, 4441.600255976913, 3384.5430866833153, 3449.534312867781, 3455.0560406523678, 3495.318412909509, 3499.8775042873376, 584.7660935625698, 586.2320360327984, 587.1369087441454, 591.2461611445356, 600.8407771940439, 622.2346513788066, 624.1137584629837, 646.6346514219451, 670.8893032649655, 671.2750229751856, 7660.655270512841, 8646.265067469336, 8916.420432671985, 8986.595603197871, 9093.4998575079, 528.3685995235656, 658.1608449227178, 661.4245606322434, 663.6714826160985, 665.9733610655617, 3874.593167717349, 4269.188854117708, 4403.9779801100785, 4447.510773814878, 4453.265211240109, 111719.32421013691, 113168.86831131583, 113996.0, 116454.8354516444, 119570.0, 72459.0, 80583.0, 92553.5372323134, 101780.49109754404, 104017.0, 74778.5044299111, 75633.0, 80569.0, 82412.0, 85890.69929055976, 7687.615619218905, 7878.4091193161885, 9053.411528250643, 9477.952610236905, 9531.47576883278, 40038.39942400924, 42919.57080429156, 48102.518974809806, 53763.73118134384, 54959.900801984535, 69354.3064569368, 73466.16334591678, 74895.62552187205, 75528.24471755212, 78342.0, 12185.329806860707, 12235.87764122383, 12327.69180770488, 12429.378531073591, 12605.916456072326, 13708.93145534266, 13783.104098233583, 13921.373538191008, 14055.859441405455, 14058.367373468423, 10895.182861285593, 11836.881631183578, 12034.338111403957, 12976.286304253357, 13095.41070651842, 12256.693582660148, 12381.0, 12489.313087779896, 12712.936435317764, 12902.354882256037, 12341.876581234073, 12575.622731318075, 12603.810942836048, 12640.051996100514, 12897.613071607866, 10553.63062292816, 10836.403997780199, 11181.0, 11308.886911130783, 11347.48936297852, 10283.94858025735, 11125.610603628835, 11185.105191584491, 11292.43537823122, 11338.263012904135], "value": 7087.932458915092, "unit": "score"}], "name": "dromaeo_css", "value": 7120.325566732394, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 113.0, 115.0, 114.0, 114.0, 113.0, 113.0, 113.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 138.0, 140.0, 142.0, 111.0, 110.0, 108.0, 109.0, 141.0, 111.0], "value": 125.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 186.0, 183.0, 182.0, 184.0, 185.0, 184.0, 183.0, 184.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 58.0, 90.0, 59.0, 58.0, 58.0, 58.0, 79.0, 58.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 95.0, 69.0, 68.0, 69.0, 90.0, 68.0, 68.0, 92.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 90.0, 87.0, 89.0, 88.0, 89.0, 71.0, 132.0, 130.0], "value": 94.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 149.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 103.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 92.0, 128.0, 128.0, 84.0, 84.0, 84.0, 83.0, 81.0], "value": 92.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 56.0, 53.0, 56.0, 58.0, 57.0, 56.0, 56.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 67.0, 75.0, 75.0, 69.0, 69.0, 70.0, 69.0, 71.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 85.0, 84.0, 83.0, 83.0, 84.0, 82.0, 97.0, 108.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 140.0, 140.0, 146.0, 146.0, 148.0, 141.0, 182.0, 186.0], "value": 151.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 173.0, 172.0, 173.0, 170.0, 172.0, 169.0, 173.0, 183.0, 170.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 68.0, 68.0, 70.0, 66.0, 68.0, 68.0, 68.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1468.1999999999998, "alertThreshold": 2.0}]} 02:54:22 INFO - Return code: 0 02:54:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:54:22 INFO - # TBPL SUCCESS # 02:54:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:54:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:54:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:54:22 INFO - 2017-01-17 02:54:22.933 screenresolution[1653:9747] starting screenresolution argv=screenresolution get 02:54:22 INFO - 2017-01-17 02:54:22.936 screenresolution[1653:9747] Display 0: 1600x1200x32@60 02:54:22 INFO - 2017-01-17 02:54:22.942 screenresolution[1654:9751] starting screenresolution argv=screenresolution list 02:54:22 INFO - Available Modes on Display 0 02:54:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:54:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:54:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:54:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:54:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:54:23 INFO - Intel Iris: 02:54:23 INFO - Chipset Model: Intel Iris 02:54:23 INFO - Type: GPU 02:54:23 INFO - Bus: Built-In 02:54:23 INFO - VRAM (Dynamic, Max): 1536 MB 02:54:23 INFO - Vendor: Intel (0x8086) 02:54:23 INFO - Device ID: 0x0a2e 02:54:23 INFO - Revision ID: 0x0009 02:54:23 INFO - Displays: 02:54:23 INFO - Display: 02:54:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:54:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:54:23 INFO - Display Serial Number: 1600x1200 60 02:54:23 INFO - Main Display: Yes 02:54:23 INFO - Mirror: Off 02:54:23 INFO - Online: Yes 02:54:23 INFO - Rotation: Supported 02:54:23 INFO - Return code: 0 02:54:23 INFO - Running post-action listener: _resource_record_post_action 02:54:23 INFO - [mozharness: 2017-01-17 10:54:23.186058Z] Finished run-tests step (success) 02:54:23 INFO - Running post-run listener: _resource_record_post_run 02:54:23 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 38941696; Write bytes: 659160064; Read time: 382; Write time: 2056 02:54:23 INFO - TinderboxPrint: CPU usage
53.6% 02:54:23 INFO - TinderboxPrint: I/O read bytes / time
38,941,696 / 382 02:54:23 INFO - TinderboxPrint: I/O write bytes / time
659,160,064 / 2,056 02:54:23 INFO - TinderboxPrint: CPU idle
2,251.2 (46.4%) 02:54:23 INFO - TinderboxPrint: CPU system
970.9 (20.0%) 02:54:23 INFO - TinderboxPrint: CPU user
1,627.6 (33.6%) 02:54:23 INFO - TinderboxPrint: Swap in / out
387,788,800 / 0 02:54:23 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 341006848; Write bytes: 335246848; Read time: 26778; Write time: 684 02:54:23 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 37975040; Write bytes: 307238400; Read time: 366; Write time: 1322 02:54:23 INFO - Running post-run listener: _upload_blobber_files 02:54:23 INFO - Blob upload gear active. 02:54:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:54:23 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 02:54:23 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'] 02:54:23 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 02:54:24 INFO - (blobuploader) - INFO - Open directory for files ... 02:54:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:54:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:54:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:25 INFO - (blobuploader) - INFO - Done attempting. 02:54:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:54:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:54:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:26 INFO - (blobuploader) - INFO - Done attempting. 02:54:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:54:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:54:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:28 INFO - (blobuploader) - INFO - Done attempting. 02:54:28 INFO - (blobuploader) - INFO - Iteration through files over. 02:54:28 INFO - Return code: 0 02:54:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:54:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:54:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1051b770bfaa9d67eba5cea52cf8275b4b19c7e94c8b2e804be038a080d7625bdb228ddb01196b3a0ea630e540a8eac9e812e2c9c701b0b368d8b292c320ba58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/771abac261a80ef9c04d60b94a752c5a644970ce6f8818e370c210573f0ae12d9cc6279e716f6feff35214d4d65dbb83b6d787fa46edf5b7a20e46eb715cd6f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28e10f4ede948a95c27b88870c9c8eef4a60431e83f468ea306c5e601c778a87a7d6a54198b015511fb7e3c8218575daf2d4af97cf3aca0807dc191a9d87dfc6"} 02:54:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:54:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:54:28 INFO - Contents: 02:54:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1051b770bfaa9d67eba5cea52cf8275b4b19c7e94c8b2e804be038a080d7625bdb228ddb01196b3a0ea630e540a8eac9e812e2c9c701b0b368d8b292c320ba58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/771abac261a80ef9c04d60b94a752c5a644970ce6f8818e370c210573f0ae12d9cc6279e716f6feff35214d4d65dbb83b6d787fa46edf5b7a20e46eb715cd6f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28e10f4ede948a95c27b88870c9c8eef4a60431e83f468ea306c5e601c778a87a7d6a54198b015511fb7e3c8218575daf2d4af97cf3aca0807dc191a9d87dfc6"} 02:54:28 INFO - Running post-run listener: copy_logs_to_upload_dir 02:54:28 INFO - Copying logs to upload dir... 02:54:28 INFO - mkdir: /builds/slave/test/build/upload/logs 02:54:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.449893 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-01-17 02:54:28.976400) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 02:54:28.980199) ========= 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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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/1051b770bfaa9d67eba5cea52cf8275b4b19c7e94c8b2e804be038a080d7625bdb228ddb01196b3a0ea630e540a8eac9e812e2c9c701b0b368d8b292c320ba58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/771abac261a80ef9c04d60b94a752c5a644970ce6f8818e370c210573f0ae12d9cc6279e716f6feff35214d4d65dbb83b6d787fa46edf5b7a20e46eb715cd6f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28e10f4ede948a95c27b88870c9c8eef4a60431e83f468ea306c5e601c778a87a7d6a54198b015511fb7e3c8218575daf2d4af97cf3aca0807dc191a9d87dfc6"} build_url:https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011097 build_url: 'https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/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/1051b770bfaa9d67eba5cea52cf8275b4b19c7e94c8b2e804be038a080d7625bdb228ddb01196b3a0ea630e540a8eac9e812e2c9c701b0b368d8b292c320ba58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/771abac261a80ef9c04d60b94a752c5a644970ce6f8818e370c210573f0ae12d9cc6279e716f6feff35214d4d65dbb83b6d787fa46edf5b7a20e46eb715cd6f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28e10f4ede948a95c27b88870c9c8eef4a60431e83f468ea306c5e601c778a87a7d6a54198b015511fb7e3c8218575daf2d4af97cf3aca0807dc191a9d87dfc6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 02:54:29.014467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 02:54:29.014762) ========= 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.uuX3KNWuP6/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.hQ6kHz0KG0/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.005037 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 02:54:29.063679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 02:54:29.064001) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 02:54:29.065537) ========= ========= Total master_lag: 0.18 =========