builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0235 starttime: 1483995773.43 results: success (0) buildid: 20170109115807 builduid: e788d52cb795472e8cb3166f837ee7d9 revision: 9fb0bcde1a7f566356097330bf5b565b33bc00fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 13:02:53.425523) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 13:02:53.425991) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 13:02:53.426276) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 13:02:53.451282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 13:02:53.451661) ========= 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.taeBmiTfbc/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.3sphXo7fV5/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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-09 13:02:53-- 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% 10.0M=0.001s 2017-01-09 13:02:53 (10.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.073768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 13:02:53.548865) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 13:02:53.549183) ========= 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.taeBmiTfbc/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.3sphXo7fV5/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.020352 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 13:02:53.597953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-09 13:02:53.598312) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9fb0bcde1a7f566356097330bf5b565b33bc00fc --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 9fb0bcde1a7f566356097330bf5b565b33bc00fc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.taeBmiTfbc/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.3sphXo7fV5/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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-09 13:02:53,675 truncating revision to first 12 chars 2017-01-09 13:02:53,675 Setting DEBUG logging. 2017-01-09 13:02:53,675 attempt 1/10 2017-01-09 13:02:53,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9fb0bcde1a7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 13:02:55,422 unpacking tar archive at: mozilla-aurora-9fb0bcde1a7f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.005428 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-09 13:02:55.627167) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 13:02:55.627675) ========= script_repo_revision: 9fb0bcde1a7f566356097330bf5b565b33bc00fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 13:02:55.628285) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 13:02:55.628711) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 13:02:55.649511) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-01-09 13:02:55.650154) ========= /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.taeBmiTfbc/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.3sphXo7fV5/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 13:02:55 INFO - MultiFileLogger online at 20170109 13:02:55 in /builds/slave/test 13:02:55 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 13:02:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:02:55 INFO - {'append_to_log': False, 13:02:55 INFO - 'base_work_dir': '/builds/slave/test', 13:02:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:02:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:02:55 INFO - 'branch': 'Mozilla-Aurora', 13:02:55 INFO - 'buildbot_json_path': 'buildprops.json', 13:02:55 INFO - 'config_files': ('talos/mac_config.py',), 13:02:55 INFO - 'default_actions': ('clobber', 13:02:55 INFO - 'read-buildbot-config', 13:02:55 INFO - 'download-and-extract', 13:02:55 INFO - 'populate-webroot', 13:02:55 INFO - 'create-virtualenv', 13:02:55 INFO - 'install', 13:02:55 INFO - 'run-tests'), 13:02:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:02:55 INFO - 'download_minidump_stackwalk': True, 13:02:55 INFO - 'download_symbols': 'ondemand', 13:02:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:02:55 INFO - 'tooltool.py': '/tools/tooltool.py', 13:02:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:02:55 INFO - '/tools/misc-python/virtualenv.py')}, 13:02:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:02:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:02:55 INFO - 'installer_path': 'installer.exe', 13:02:55 INFO - 'log_level': 'info', 13:02:55 INFO - 'log_name': 'talos', 13:02:55 INFO - 'log_to_console': True, 13:02:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:02:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:02:55 INFO - 'opt_config_files': (), 13:02:55 INFO - 'pip_index': False, 13:02:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:02:55 INFO - 'cmd': ('bash', 13:02:55 INFO - '-c', 13:02:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:02:55 INFO - 'enabled': True, 13:02:55 INFO - 'halt_on_failure': False, 13:02:55 INFO - 'name': 'check_screen_resolution'},), 13:02:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:02:55 INFO - 'cmd': ('bash', 13:02:55 INFO - '-c', 13:02:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:02:55 INFO - 'enabled': True, 13:02:55 INFO - 'halt_on_failure': False, 13:02:55 INFO - 'name': 'check_screen_resolution'},), 13:02:55 INFO - 'run_cmd_checks_enabled': True, 13:02:55 INFO - 'sps_profile': False, 13:02:55 INFO - 'sps_profile_interval': 0, 13:02:55 INFO - 'suite': 'dromaeojs', 13:02:55 INFO - 'system_bits': '32', 13:02:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:02:55 INFO - 'title': 't-yosemite-r7-0235', 13:02:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:02:55 INFO - 'use_talos_json': True, 13:02:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:02:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:02:55 INFO - 'work_dir': 'build'} 13:02:55 INFO - [mozharness: 2017-01-09 21:02:55.844477Z] Running clobber step. 13:02:55 INFO - Running pre-action listener: _resource_record_pre_action 13:02:55 INFO - Running main action method: clobber 13:02:55 INFO - rmtree: /builds/slave/test/build 13:02:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:02:57 INFO - Running post-action listener: _resource_record_post_action 13:02:57 INFO - [mozharness: 2017-01-09 21:02:57.418174Z] Finished clobber step (success) 13:02:57 INFO - [mozharness: 2017-01-09 21:02:57.418297Z] Running read-buildbot-config step. 13:02:57 INFO - Running pre-action listener: _resource_record_pre_action 13:02:57 INFO - Running main action method: read_buildbot_config 13:02:57 INFO - Using buildbot properties: 13:02:57 INFO - { 13:02:57 INFO - "project": "", 13:02:57 INFO - "product": "firefox", 13:02:57 INFO - "script_repo_revision": "production", 13:02:57 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 13:02:57 INFO - "repository": "", 13:02:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 13:02:57 INFO - "buildid": "20170109115807", 13:02:57 INFO - "pgo_build": "False", 13:02:57 INFO - "basedir": "/builds/slave/test", 13:02:57 INFO - "buildnumber": 39, 13:02:57 INFO - "slavename": "t-yosemite-r7-0235", 13:02:57 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 13:02:57 INFO - "platform": "yosemite_r7", 13:02:57 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:02:57 INFO - "branch": "mozilla-aurora", 13:02:57 INFO - "repo_path": "releases/mozilla-aurora", 13:02:57 INFO - "revision": "9fb0bcde1a7f566356097330bf5b565b33bc00fc", 13:02:57 INFO - "stage_platform": "macosx64", 13:02:57 INFO - "builduid": "e788d52cb795472e8cb3166f837ee7d9", 13:02:57 INFO - "slavebuilddir": "test" 13:02:57 INFO - } 13:02:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 13:02:57 INFO - Running post-action listener: _resource_record_post_action 13:02:57 INFO - [mozharness: 2017-01-09 21:02:57.421650Z] Finished read-buildbot-config step (success) 13:02:57 INFO - [mozharness: 2017-01-09 21:02:57.421774Z] Running download-and-extract step. 13:02:57 INFO - Running pre-action listener: _resource_record_pre_action 13:02:57 INFO - Running main action method: download_and_extract 13:02:57 INFO - mkdir: /builds/slave/test/build/tests 13:02:57 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')]} 13:02:57 INFO - trying https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 13:02:57 INFO - Downloading https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/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 13:02:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/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 13:02:58 INFO - Downloaded 1199 bytes. 13:02:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 13:02:58 INFO - Using the following test package requirements: 13:02:58 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 13:02:58 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:02:58 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 13:02:58 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:02:58 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 13:02:58 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:02:58 INFO - u'jsshell-mac.zip'], 13:02:58 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:02:58 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 13:02:58 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 13:02:58 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:02:58 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 13:02:58 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:02:58 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 13:02:58 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:02:58 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 13:02:58 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:02:58 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 13:02:58 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:02:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 13:02:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:02:58 INFO - Fetch https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 13:02:58 INFO - Http code: 200 13:02:58 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 13:02:58 INFO - x-amz-cf-id: a1Gk74twK3sV4Y_ZZH4XbObECszSp-Y7vsswrT6fx1TQM6R5HdMC4g== 13:02:58 INFO - x-amz-version-id: hMPzVbYi6mMYeEF2lKVtL866lDNxYRQH 13:02:59 INFO - Expected file size: 16270888 13:02:59 INFO - Obtained file size: 16270888 13:03:05 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 13:03:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 13:03:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:03:05 INFO - Fetch https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 13:03:06 INFO - Http code: 200 13:03:06 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 13:03:06 INFO - x-amz-cf-id: xOnIBgTuQRZcCfw7Ji5pcz0cmeasmBPk_NhJUtmpG-kFQXYMaWw9GA== 13:03:06 INFO - x-amz-version-id: hMPzVbYi6mMYeEF2lKVtL866lDNxYRQH 13:03:06 INFO - Expected file size: 16270888 13:03:06 INFO - Obtained file size: 16270888 13:03:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 13:03:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:03:13 INFO - Fetch https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 13:03:13 INFO - Http code: 200 13:03:13 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 13:03:13 INFO - x-amz-cf-id: SOjxRNEvzbbfG0liim3vIS09k4FwaQ_s_pBhE4EPz9exrmclvv3O1A== 13:03:13 INFO - x-amz-version-id: mLuwUE4P6OBmgnO9uVxolaC9y0fCCowE 13:03:13 INFO - Expected file size: 14409038 13:03:13 INFO - Obtained file size: 14409038 13:03:14 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')]} 13:03:14 INFO - trying https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:03:14 INFO - Downloading https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 13:03:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/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 13:03:17 INFO - Downloaded 109875319 bytes. 13:03:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:03:17 INFO - mkdir: /builds/slave/test/properties 13:03:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:03:17 INFO - Writing to file /builds/slave/test/properties/build_url 13:03:17 INFO - Contents: 13:03:17 INFO - build_url:https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:03:17 INFO - Running post-action listener: _resource_record_post_action 13:03:17 INFO - Running post-action listener: set_extra_try_arguments 13:03:17 INFO - [mozharness: 2017-01-09 21:03:17.697532Z] Finished download-and-extract step (success) 13:03:17 INFO - [mozharness: 2017-01-09 21:03:17.697669Z] Running populate-webroot step. 13:03:17 INFO - Running pre-action listener: _resource_record_pre_action 13:03:17 INFO - Running main action method: populate_webroot 13:03:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:03:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:03:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:03:17 INFO - '--tppagecycles', 13:03:17 INFO - '7'], 13:03:17 INFO - 'tests': ['tsvgm']}}, 13:03:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:03:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:03:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:03:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:03:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:03:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:03:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:17 INFO - 'talos_options': ['--disable-e10s'], 13:03:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:03:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:03:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:17 INFO - 'talos_options': ['--disable-e10s'], 13:03:17 INFO - 'tests': ['damp', 'tps']}, 13:03:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:17 INFO - 'tests': ['damp', 'tps']}, 13:03:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:03:17 INFO - 'tests': ['dromaeo_dom']}, 13:03:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:03:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:03:17 INFO - 'tests': ['basic_compositor_video']}, 13:03:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:03:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:03:17 INFO - 'tests': ['a11yr', 13:03:17 INFO - 'ts_paint', 13:03:17 INFO - 'tpaint', 13:03:17 INFO - 'sessionrestore', 13:03:17 INFO - 'sessionrestore_no_auto_restore', 13:03:17 INFO - 'tabpaint']}, 13:03:17 INFO - 'other-e10s': {'tests': ['a11yr', 13:03:17 INFO - 'ts_paint', 13:03:17 INFO - 'tpaint', 13:03:17 INFO - 'sessionrestore', 13:03:17 INFO - 'sessionrestore_no_auto_restore', 13:03:17 INFO - 'tabpaint']}, 13:03:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:03:17 INFO - 'ts_paint', 13:03:17 INFO - 'tpaint', 13:03:17 INFO - 'sessionrestore', 13:03:17 INFO - 'sessionrestore_no_auto_restore', 13:03:17 INFO - 'tabpaint']}, 13:03:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:03:17 INFO - 'ts_paint', 13:03:17 INFO - 'tpaint', 13:03:17 INFO - 'sessionrestore', 13:03:17 INFO - 'sessionrestore_no_auto_restore', 13:03:17 INFO - 'tabpaint']}, 13:03:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:03:17 INFO - 'tests': ['a11yr', 13:03:17 INFO - 'ts_paint', 13:03:17 INFO - 'tpaint', 13:03:17 INFO - 'sessionrestore', 13:03:17 INFO - 'sessionrestore_no_auto_restore', 13:03:17 INFO - 'tabpaint']}, 13:03:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:03:17 INFO - 'tests': ['a11yr', 13:03:17 INFO - 'ts_paint', 13:03:17 INFO - 'tpaint', 13:03:17 INFO - 'sessionrestore', 13:03:17 INFO - 'sessionrestore_no_auto_restore', 13:03:17 INFO - 'tabpaint']}, 13:03:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:03:17 INFO - 'tests': ['tsvgx', 13:03:17 INFO - 'tsvgr_opacity', 13:03:17 INFO - 'tart', 13:03:17 INFO - 'tscrollx', 13:03:17 INFO - 'cart']}, 13:03:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:03:17 INFO - 'tsvgr_opacity', 13:03:17 INFO - 'tart', 13:03:17 INFO - 'tscrollx', 13:03:17 INFO - 'cart']}, 13:03:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:17 INFO - 'talos_options': ['--disable-e10s'], 13:03:17 INFO - 'tests': ['tp5o']}, 13:03:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:17 INFO - 'tests': ['tp5o']}, 13:03:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:17 INFO - 'talos_options': ['--disable-e10s', 13:03:17 INFO - '--xperf_path', 13:03:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:03:17 INFO - 'tests': ['tp5n']}, 13:03:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:17 INFO - 'talos_options': ['--xperf_path', 13:03:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:03:17 INFO - 'tests': ['tp5n']}}, 13:03:17 INFO - 'talos.zip': {'path': '', 13:03:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:03:17 INFO - Running post-action listener: _resource_record_post_action 13:03:17 INFO - [mozharness: 2017-01-09 21:03:17.716007Z] Finished populate-webroot step (success) 13:03:17 INFO - [mozharness: 2017-01-09 21:03:17.716113Z] Running create-virtualenv step. 13:03:17 INFO - Running pre-action listener: _resource_record_pre_action 13:03:17 INFO - Running main action method: create_virtualenv 13:03:17 INFO - Creating virtualenv /builds/slave/test/build/venv 13:03:17 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 13:03:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:03:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:03:17 INFO - Using real prefix '/tools/python27' 13:03:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:03:18 INFO - Installing distribute.............................................................................................................................................................................................done. 13:03:21 INFO - Installing pip.................done. 13:03:21 INFO - Return code: 0 13:03:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:03:21 INFO - Reading from file tmpfile_stdout 13:03:21 INFO - Output received: 13:03:21 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) 13:03:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:21 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 0x108d54490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdfbcc9500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b68d30>, '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 0x1089cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b60b20>, '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.taeBmiTfbc/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.3sphXo7fV5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 13:03:21 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 13:03:21 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 13:03:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.taeBmiTfbc/Render', 13:03:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:03:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:03:21 INFO - 'HOME': '/Users/cltbld', 13:03:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:03:21 INFO - 'LOGNAME': 'cltbld', 13:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:21 INFO - 'MOZ_NO_REMOTE': '1', 13:03:21 INFO - 'NO_EM_RESTART': '1', 13:03:21 INFO - 'PAGER': '/bin/cat', 13:03:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:21 INFO - 'PWD': '/builds/slave/test', 13:03:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:03:21 INFO - 'SHELL': '/bin/bash', 13:03:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3sphXo7fV5/Listeners', 13:03:21 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 13:03:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:03:21 INFO - 'USER': 'cltbld', 13:03:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:03:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:21 INFO - 'XPC_FLAGS': '0x0', 13:03:21 INFO - 'XPC_SERVICE_NAME': '0', 13:03:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:21 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 13:03:21 INFO - Cleaning up... 13:03:21 INFO - Return code: 0 13:03:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:21 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 0x108d54490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdfbcc9500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b68d30>, '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 0x1089cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b60b20>, '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.taeBmiTfbc/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.3sphXo7fV5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 13:03:21 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 13:03:21 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 13:03:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.taeBmiTfbc/Render', 13:03:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:03:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:03:21 INFO - 'HOME': '/Users/cltbld', 13:03:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:03:21 INFO - 'LOGNAME': 'cltbld', 13:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:21 INFO - 'MOZ_NO_REMOTE': '1', 13:03:21 INFO - 'NO_EM_RESTART': '1', 13:03:21 INFO - 'PAGER': '/bin/cat', 13:03:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:21 INFO - 'PWD': '/builds/slave/test', 13:03:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:03:21 INFO - 'SHELL': '/bin/bash', 13:03:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3sphXo7fV5/Listeners', 13:03:21 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 13:03:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:03:21 INFO - 'USER': 'cltbld', 13:03:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:03:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:21 INFO - 'XPC_FLAGS': '0x0', 13:03:21 INFO - 'XPC_SERVICE_NAME': '0', 13:03:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:22 INFO - Downloading/unpacking psutil>=3.1.1 13:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:03:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:03:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:03:25 INFO - Installing collected packages: psutil 13:03:25 INFO - Running setup.py install for psutil 13:03:25 INFO - building 'psutil._psutil_osx' extension 13:03:25 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 13:03:25 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 13:03:26 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 13:03:26 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 13:03:26 INFO - building 'psutil._psutil_posix' extension 13:03:26 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 13:03:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:03:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:03:26 INFO - ^ 13:03:26 INFO - 1 warning generated. 13:03:26 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 13:03:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:03:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:03:26 INFO - Successfully installed psutil 13:03:26 INFO - Cleaning up... 13:03:26 INFO - Return code: 0 13:03:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d54490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdfbcc9500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b68d30>, '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 0x1089cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b60b20>, '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.taeBmiTfbc/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.3sphXo7fV5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 13:03:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:03:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.taeBmiTfbc/Render', 13:03:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:03:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:03:26 INFO - 'HOME': '/Users/cltbld', 13:03:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:03:26 INFO - 'LOGNAME': 'cltbld', 13:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:26 INFO - 'MOZ_NO_REMOTE': '1', 13:03:26 INFO - 'NO_EM_RESTART': '1', 13:03:26 INFO - 'PAGER': '/bin/cat', 13:03:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:26 INFO - 'PWD': '/builds/slave/test', 13:03:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:03:26 INFO - 'SHELL': '/bin/bash', 13:03:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3sphXo7fV5/Listeners', 13:03:26 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 13:03:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:03:26 INFO - 'USER': 'cltbld', 13:03:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:03:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:26 INFO - 'XPC_FLAGS': '0x0', 13:03:26 INFO - 'XPC_SERVICE_NAME': '0', 13:03:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:03:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:03:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:03:29 INFO - Installing collected packages: mozsystemmonitor 13:03:29 INFO - Running setup.py install for mozsystemmonitor 13:03:29 INFO - Successfully installed mozsystemmonitor 13:03:29 INFO - Cleaning up... 13:03:29 INFO - Return code: 0 13:03:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:29 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 0x108d54490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdfbcc9500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b68d30>, '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 0x1089cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b60b20>, '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.taeBmiTfbc/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.3sphXo7fV5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 13:03:29 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 13:03:29 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 13:03:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.taeBmiTfbc/Render', 13:03:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:03:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:03:29 INFO - 'HOME': '/Users/cltbld', 13:03:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:03:29 INFO - 'LOGNAME': 'cltbld', 13:03:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:29 INFO - 'MOZ_NO_REMOTE': '1', 13:03:29 INFO - 'NO_EM_RESTART': '1', 13:03:29 INFO - 'PAGER': '/bin/cat', 13:03:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:03:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:29 INFO - 'PWD': '/builds/slave/test', 13:03:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:03:29 INFO - 'SHELL': '/bin/bash', 13:03:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3sphXo7fV5/Listeners', 13:03:29 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 13:03:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:03:29 INFO - 'USER': 'cltbld', 13:03:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:03:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:03:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:29 INFO - 'XPC_FLAGS': '0x0', 13:03:29 INFO - 'XPC_SERVICE_NAME': '0', 13:03:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:03:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:29 INFO - Downloading/unpacking jsonschema==2.5.1 13:03:29 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 13:03:29 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 13:03:29 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 13:03:29 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 13:03:29 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 13:03:29 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 13:03:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:03:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:03:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:03:32 INFO - warning: no files found matching '*.txt' 13:03:32 INFO - no previously-included directories found matching 'build' 13:03:32 INFO - no previously-included directories found matching 'dist' 13:03:32 INFO - no previously-included directories found matching '.git*' 13:03:32 INFO - Installing collected packages: jsonschema, functools32 13:03:33 INFO - Running setup.py install for functools32 13:03:33 INFO - warning: no files found matching '*.txt' 13:03:33 INFO - no previously-included directories found matching 'build' 13:03:33 INFO - no previously-included directories found matching 'dist' 13:03:33 INFO - no previously-included directories found matching '.git*' 13:03:33 INFO - Successfully installed jsonschema functools32 13:03:33 INFO - Cleaning up... 13:03:33 INFO - Return code: 0 13:03:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:03: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')]} 13:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03: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')]} 13:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:33 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 0x108d54490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdfbcc9500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b68d30>, '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 0x1089cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b60b20>, '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.taeBmiTfbc/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.3sphXo7fV5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 13:03:33 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 13:03:33 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 13:03:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.taeBmiTfbc/Render', 13:03:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:03:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:03:33 INFO - 'HOME': '/Users/cltbld', 13:03:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:03:33 INFO - 'LOGNAME': 'cltbld', 13:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:33 INFO - 'MOZ_NO_REMOTE': '1', 13:03:33 INFO - 'NO_EM_RESTART': '1', 13:03:33 INFO - 'PAGER': '/bin/cat', 13:03:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:33 INFO - 'PWD': '/builds/slave/test', 13:03:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:03:33 INFO - 'SHELL': '/bin/bash', 13:03:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3sphXo7fV5/Listeners', 13:03:33 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 13:03:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:03:33 INFO - 'USER': 'cltbld', 13:03:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:03:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:33 INFO - 'XPC_FLAGS': '0x0', 13:03:33 INFO - 'XPC_SERVICE_NAME': '0', 13:03:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:03:33 INFO - Cleaning up... 13:03:33 INFO - Return code: 0 13:03:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:03: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')]} 13:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03: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')]} 13:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:33 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 0x108d54490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdfbcc9500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b68d30>, '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 0x1089cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b60b20>, '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.taeBmiTfbc/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.3sphXo7fV5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 13:03:33 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 13:03:33 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 13:03:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.taeBmiTfbc/Render', 13:03:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:03:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:03:33 INFO - 'HOME': '/Users/cltbld', 13:03:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:03:33 INFO - 'LOGNAME': 'cltbld', 13:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:33 INFO - 'MOZ_NO_REMOTE': '1', 13:03:33 INFO - 'NO_EM_RESTART': '1', 13:03:33 INFO - 'PAGER': '/bin/cat', 13:03:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:33 INFO - 'PWD': '/builds/slave/test', 13:03:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:03:33 INFO - 'SHELL': '/bin/bash', 13:03:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3sphXo7fV5/Listeners', 13:03:33 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 13:03:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:03:33 INFO - 'USER': 'cltbld', 13:03:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:03:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:33 INFO - 'XPC_FLAGS': '0x0', 13:03:33 INFO - 'XPC_SERVICE_NAME': '0', 13:03:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:33 INFO - Downloading/unpacking blobuploader==1.2.4 13:03:33 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 13:03:33 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 13:03:33 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 13:03:33 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 13:03:33 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 13:03:33 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 13:03:36 INFO - Downloading blobuploader-1.2.4.tar.gz 13:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:03:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:03:36 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 13:03:36 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 13:03:36 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 13:03:36 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 13:03:36 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 13:03:36 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 13:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:03:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:03:37 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 13:03:37 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 13:03:37 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 13:03:37 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 13:03:37 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 13:03:37 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 13:03:37 INFO - Downloading docopt-0.6.1.tar.gz 13:03:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:03:37 INFO - Installing collected packages: blobuploader, requests, docopt 13:03:37 INFO - Running setup.py install for blobuploader 13:03:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:03:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:03:37 INFO - Running setup.py install for requests 13:03:38 INFO - Running setup.py install for docopt 13:03:38 INFO - Successfully installed blobuploader requests docopt 13:03:38 INFO - Cleaning up... 13:03:38 INFO - Return code: 0 13:03:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:03:38 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')]} 13:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:38 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')]} 13:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:38 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 0x108d54490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdfbcc9500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b68d30>, '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 0x1089cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b60b20>, '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.taeBmiTfbc/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.3sphXo7fV5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 13:03:38 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 13:03:38 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 13:03:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.taeBmiTfbc/Render', 13:03:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:03:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:03:38 INFO - 'HOME': '/Users/cltbld', 13:03:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:03:38 INFO - 'LOGNAME': 'cltbld', 13:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:38 INFO - 'MOZ_NO_REMOTE': '1', 13:03:38 INFO - 'NO_EM_RESTART': '1', 13:03:38 INFO - 'PAGER': '/bin/cat', 13:03:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:38 INFO - 'PWD': '/builds/slave/test', 13:03:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:03:38 INFO - 'SHELL': '/bin/bash', 13:03:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3sphXo7fV5/Listeners', 13:03:38 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 13:03:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:03:38 INFO - 'USER': 'cltbld', 13:03:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:03:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:38 INFO - 'XPC_FLAGS': '0x0', 13:03:38 INFO - 'XPC_SERVICE_NAME': '0', 13:03:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:03:38 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-eX1qsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:03:38 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-bNASRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:03:39 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-iJnuuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:03:39 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-QM0Lva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:03:39 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-HAorgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:03:39 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-eRwd0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:03:39 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-iI644B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:03:39 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ZjLFiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:03:39 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-TpTTnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:03:39 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-IgM29Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:03:39 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-1fIvHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:03:40 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-0L6cCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:03:40 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-kEaPX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:03:40 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ZmB6Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:40 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-4ZWQsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:03:40 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-1WeWWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:03:40 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-tPvVi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:03:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:03:40 INFO - Running setup.py install for manifestparser 13:03:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:03:40 INFO - Running setup.py install for mozcrash 13:03:40 INFO - Running setup.py install for mozdebug 13:03:41 INFO - Running setup.py install for mozdevice 13:03:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:03:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:03:41 INFO - Running setup.py install for mozfile 13:03:41 INFO - Running setup.py install for mozhttpd 13:03:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:03:41 INFO - Running setup.py install for mozinfo 13:03:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:03:41 INFO - Running setup.py install for mozInstall 13:03:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:03:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:03:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:03:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:03:41 INFO - Running setup.py install for mozleak 13:03:41 INFO - Running setup.py install for mozlog 13:03:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:03:42 INFO - Running setup.py install for moznetwork 13:03:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:03:42 INFO - Running setup.py install for mozprocess 13:03:42 INFO - Running setup.py install for mozprofile 13:03:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:03:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:03:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:03:42 INFO - Running setup.py install for mozrunner 13:03:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:03:42 INFO - Running setup.py install for mozscreenshot 13:03:42 INFO - Running setup.py install for moztest 13:03:43 INFO - Running setup.py install for mozversion 13:03:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:03:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:03:43 INFO - Cleaning up... 13:03:43 INFO - Return code: 0 13:03:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:03:43 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')]} 13:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:43 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')]} 13:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:43 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 0x108d54490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdfbcc9500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b68d30>, '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 0x1089cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b60b20>, '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.taeBmiTfbc/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.3sphXo7fV5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 13:03:43 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 13:03:43 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 13:03:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.taeBmiTfbc/Render', 13:03:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:03:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:03:43 INFO - 'HOME': '/Users/cltbld', 13:03:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:03:43 INFO - 'LOGNAME': 'cltbld', 13:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:43 INFO - 'MOZ_NO_REMOTE': '1', 13:03:43 INFO - 'NO_EM_RESTART': '1', 13:03:43 INFO - 'PAGER': '/bin/cat', 13:03:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:43 INFO - 'PWD': '/builds/slave/test', 13:03:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:03:43 INFO - 'SHELL': '/bin/bash', 13:03:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3sphXo7fV5/Listeners', 13:03:43 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 13:03:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:03:43 INFO - 'USER': 'cltbld', 13:03:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:03:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:43 INFO - 'XPC_FLAGS': '0x0', 13:03:43 INFO - 'XPC_SERVICE_NAME': '0', 13:03:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:03:43 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-e0COFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:03:43 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)) 13:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:03:43 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-aGciOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:03:43 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)) 13:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:03:43 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-bgpxHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:03:43 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)) 13:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:03:43 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ikcH7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:03:43 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)) 13:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:03:43 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-OizRHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:03:44 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)) 13:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:03:44 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-D5T2nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:03:44 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)) 13:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:03:44 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-DmeKI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:03:44 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)) 13:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:03:44 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-D2myr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:03:44 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)) 13:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:03:44 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-xX7cTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:03:44 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)) 13:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:03:44 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-hhdtCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:03:44 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)) 13:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:03:44 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-RCu8xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:03:44 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)) 13:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:03:44 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-SssB7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:03:44 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)) 13:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:03:44 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-WXMpDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:03:44 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)) 13:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:03:44 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-cky96f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:03:45 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)) 13:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:45 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-whohlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:45 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)) 13:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:03:45 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-CNEDpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:03:45 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)) 13:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:03:45 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-binYij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:03:45 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)) 13:03:45 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)) 13:03:45 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)) 13:03:45 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)) 13:03:45 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)) 13:03:45 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)) 13:03:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:03:45 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 13:03:45 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 13:03:45 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 13:03:45 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 13:03:45 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 13:03:45 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 13:03:47 INFO - Downloading blessings-1.6.tar.gz 13:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:03:47 INFO - Installing collected packages: blessings 13:03:47 INFO - Running setup.py install for blessings 13:03:48 INFO - Successfully installed blessings 13:03:48 INFO - Cleaning up... 13:03:48 INFO - Return code: 0 13:03:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:03:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:03:48 INFO - Reading from file tmpfile_stdout 13:03:48 INFO - Current package versions: 13:03:48 INFO - blessings == 1.6 13:03:48 INFO - blobuploader == 1.2.4 13:03:48 INFO - docopt == 0.6.1 13:03:48 INFO - functools32 == 3.2.3-2 13:03:48 INFO - jsonschema == 2.5.1 13:03:48 INFO - manifestparser == 1.1 13:03:48 INFO - mozInstall == 1.12 13:03:48 INFO - mozcrash == 1.0 13:03:48 INFO - mozdebug == 0.1 13:03:48 INFO - mozdevice == 0.48 13:03:48 INFO - mozfile == 1.2 13:03:48 INFO - mozhttpd == 0.7 13:03:48 INFO - mozinfo == 0.9 13:03:48 INFO - mozleak == 0.1 13:03:48 INFO - mozlog == 3.4 13:03:48 INFO - moznetwork == 0.27 13:03:48 INFO - mozprocess == 0.23 13:03:48 INFO - mozprofile == 0.28 13:03:48 INFO - mozrunner == 6.13 13:03:48 INFO - mozscreenshot == 0.1 13:03:48 INFO - mozsystemmonitor == 0.3 13:03:48 INFO - moztest == 0.8 13:03:48 INFO - mozversion == 1.4 13:03:48 INFO - psutil == 3.1.1 13:03:48 INFO - requests == 1.2.3 13:03:48 INFO - wsgiref == 0.1.2 13:03:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:03:48 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')]} 13:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:48 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')]} 13:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:48 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 0x108d54490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdfbcc9500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b68d30>, '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 0x1089cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b60b20>, '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.taeBmiTfbc/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.3sphXo7fV5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 13:03:48 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 13:03:48 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 13:03:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.taeBmiTfbc/Render', 13:03:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:03:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:03:48 INFO - 'HOME': '/Users/cltbld', 13:03:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:03:48 INFO - 'LOGNAME': 'cltbld', 13:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:48 INFO - 'MOZ_NO_REMOTE': '1', 13:03:48 INFO - 'NO_EM_RESTART': '1', 13:03:48 INFO - 'PAGER': '/bin/cat', 13:03:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:48 INFO - 'PWD': '/builds/slave/test', 13:03:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:03:48 INFO - 'SHELL': '/bin/bash', 13:03:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3sphXo7fV5/Listeners', 13:03:48 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 13:03:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:03:48 INFO - 'USER': 'cltbld', 13:03:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:03:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:48 INFO - 'XPC_FLAGS': '0x0', 13:03:48 INFO - 'XPC_SERVICE_NAME': '0', 13:03:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:48 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)) 13:03:48 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)) 13:03:48 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)) 13:03:48 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)) 13:03:48 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)) 13:03:48 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)) 13:03:48 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)) 13:03:48 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)) 13:03:48 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)) 13:03:48 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)) 13:03:48 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)) 13:03:48 INFO - Cleaning up... 13:03:48 INFO - Return code: 0 13:03:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:03:48 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')]} 13:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:48 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')]} 13:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:48 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 0x108d54490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdfbcc9500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b68d30>, '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 0x1089cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b60b20>, '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.taeBmiTfbc/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.3sphXo7fV5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 13:03:48 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 13:03:48 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 13:03:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.taeBmiTfbc/Render', 13:03:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:03:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:03:48 INFO - 'HOME': '/Users/cltbld', 13:03:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:03:48 INFO - 'LOGNAME': 'cltbld', 13:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:48 INFO - 'MOZ_NO_REMOTE': '1', 13:03:48 INFO - 'NO_EM_RESTART': '1', 13:03:48 INFO - 'PAGER': '/bin/cat', 13:03:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:48 INFO - 'PWD': '/builds/slave/test', 13:03:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:03:48 INFO - 'SHELL': '/bin/bash', 13:03:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3sphXo7fV5/Listeners', 13:03:48 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 13:03:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:03:48 INFO - 'USER': 'cltbld', 13:03:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:03:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:48 INFO - 'XPC_FLAGS': '0x0', 13:03:48 INFO - 'XPC_SERVICE_NAME': '0', 13:03:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:03:49 INFO - Cleaning up... 13:03:49 INFO - Return code: 0 13:03:49 INFO - Running post-action listener: _resource_record_post_action 13:03:49 INFO - Running post-action listener: _start_resource_monitoring 13:03:49 INFO - Starting resource monitoring. 13:03:49 INFO - [mozharness: 2017-01-09 21:03:49.068063Z] Finished create-virtualenv step (success) 13:03:49 INFO - [mozharness: 2017-01-09 21:03:49.069060Z] Running install step. 13:03:49 INFO - Running pre-action listener: _resource_record_pre_action 13:03:49 INFO - Running main action method: install 13:03:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:03:49 INFO - Reading from file tmpfile_stdout 13:03:49 INFO - Detecting whether we're running mozinstall >=1.0... 13:03:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:03:49 INFO - Reading from file tmpfile_stdout 13:03:49 INFO - Output received: 13:03:49 INFO - Usage: mozinstall [options] installer 13:03:49 INFO - Options: 13:03:49 INFO - -h, --help show this help message and exit 13:03:49 INFO - -d DEST, --destination=DEST 13:03:49 INFO - Directory to install application into. [default: 13:03:49 INFO - "/builds/slave/test"] 13:03:49 INFO - --app=APP Application being installed. [default: firefox] 13:03:49 INFO - mkdir: /builds/slave/test/build/application 13:03:49 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'] 13:03:49 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 13:04:20 INFO - Reading from file tmpfile_stdout 13:04:20 INFO - Output received: 13:04:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:04:20 INFO - Running post-action listener: _resource_record_post_action 13:04:20 INFO - [mozharness: 2017-01-09 21:04:20.434291Z] Finished install step (success) 13:04:20 INFO - [mozharness: 2017-01-09 21:04:20.434465Z] Running run-tests step. 13:04:20 INFO - Running pre-action listener: _resource_record_pre_action 13:04:20 INFO - Running main action method: run_tests 13:04:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:04:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:04:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:04:20 INFO - 2017-01-09 13:04:20.449 screenresolution[2415:16396] starting screenresolution argv=screenresolution get 13:04:20 INFO - 2017-01-09 13:04:20.451 screenresolution[2415:16396] Display 0: 1600x1200x32@60 13:04:20 INFO - 2017-01-09 13:04:20.457 screenresolution[2416:16398] starting screenresolution argv=screenresolution list 13:04:20 INFO - Available Modes on Display 0 13:04:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:04:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:04:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:04:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:04:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:04:20 INFO - Intel Iris: 13:04:20 INFO - Chipset Model: Intel Iris 13:04:20 INFO - Type: GPU 13:04:20 INFO - Bus: Built-In 13:04:20 INFO - VRAM (Dynamic, Max): 1536 MB 13:04:20 INFO - Vendor: Intel (0x8086) 13:04:20 INFO - Device ID: 0x0a2e 13:04:20 INFO - Revision ID: 0x0009 13:04:20 INFO - Displays: 13:04:20 INFO - Display: 13:04:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:04:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:04:20 INFO - Display Serial Number: 1600x1200 60 13:04:20 INFO - Main Display: Yes 13:04:20 INFO - Mirror: Off 13:04:20 INFO - Online: Yes 13:04:20 INFO - Rotation: Supported 13:04:20 INFO - Return code: 0 13:04:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:04:20 INFO - Python 2.7.3 13:04:20 INFO - Return code: 0 13:04:20 INFO - grabbing minidump binary from tooltool 13:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:20 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 0x108b68d30>, '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 0x1089cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b60b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:04:20 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 13:04:20 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 13:04:20 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 13:04:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:04:20 INFO - Return code: 0 13:04:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:04:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:04:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:04:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:04:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:04:20 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/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 13:04:20 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/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0235 --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 13:04:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.taeBmiTfbc/Render', 13:04:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:20 INFO - 'HOME': '/Users/cltbld', 13:04:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:20 INFO - 'LOGNAME': 'cltbld', 13:04:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:04:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:20 INFO - 'MOZ_NO_REMOTE': '1', 13:04:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:04:20 INFO - 'NO_EM_RESTART': '1', 13:04:20 INFO - 'PAGER': '/bin/cat', 13:04:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:20 INFO - 'PWD': '/builds/slave/test', 13:04:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:04:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:20 INFO - 'SHELL': '/bin/bash', 13:04:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3sphXo7fV5/Listeners', 13:04:20 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 13:04:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:20 INFO - 'USER': 'cltbld', 13:04:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:20 INFO - 'XPC_FLAGS': '0x0', 13:04:20 INFO - 'XPC_SERVICE_NAME': '0', 13:04:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:20 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/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 13:04:21 INFO - mozversion application_buildid: 20170109115807 13:04:21 INFO - mozversion application_changeset: 9fb0bcde1a7f566356097330bf5b565b33bc00fc 13:04:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:04:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:04:21 INFO - mozversion application_name: Firefox 13:04:21 INFO - mozversion application_remotingname: firefox-dev 13:04:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:04:21 INFO - mozversion application_vendor: Mozilla 13:04:21 INFO - mozversion application_version: 52.0a2 13:04:21 INFO - mozversion platform_buildid: 20170109115807 13:04:21 INFO - mozversion platform_changeset: 9fb0bcde1a7f566356097330bf5b565b33bc00fc 13:04:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:04:21 INFO - mozversion platform_version: 52.0a2 13:04:21 INFO - using testdate: 1483995861 13:04:21 INFO - actual date: 1483995861 13:04:21 INFO - starting webserver on 'localhost:52184' 13:04:21 INFO - SUITE-START | Running 2 tests 13:04:21 INFO - TEST-START | dromaeo_css 13:04:21 INFO - operating with platform_type : mac_ 13:04:21 INFO - Initialising browser for dromaeo_css test... 13:04:21 INFO - TEST-INFO | started process 2426 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpuE4a3m/profile http://localhost:52184/getInfo.html) 13:04:23 INFO - PROCESS | 2426 | __metrics Screen width/height:1600/1200 13:04:23 INFO - PROCESS | 2426 | colorDepth:24 13:04:23 INFO - PROCESS | 2426 | Browser inner width/height: 1024/689 13:04:23 INFO - PROCESS | 2426 | __metrics 13:04:23 INFO - PROCESS | 2426 | 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" 13:04:23 INFO - PROCESS | 2426 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:04:24 INFO - TEST-INFO | 2426: exit 0 13:04:24 INFO - Browser initialized. 13:04:24 INFO - Running cycle 1/1 for dromaeo_css test... 13:04:24 INFO - TEST-INFO | started process 2429 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpuE4a3m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:04:36 INFO - PROCESS | 2429 | RSS: Main: 222932992 13:04:36 INFO - PROCESS | 2429 | 13:07:41 INFO - PROCESS | 2429 | Cycle 1(1): loaded http://localhost:52184/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52184/tests/dromaeo/cssquery-ext.html) 13:07:43 INFO - PROCESS | 2429 | RSS: Main: 370049024 13:07:43 INFO - PROCESS | 2429 | 13:10:46 INFO - PROCESS | 2429 | Cycle 1(1): loaded http://localhost:52184/tests/dromaeo/cssquery-ext.html (next: http://localhost:52184/tests/dromaeo/cssquery-jquery.html) 13:10:46 INFO - PROCESS | 2429 | RSS: Main: 347717632 13:10:46 INFO - PROCESS | 2429 | 13:13:49 INFO - PROCESS | 2429 | Cycle 1(1): loaded http://localhost:52184/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52184/tests/dromaeo/cssquery-mootools.html) 13:13:49 INFO - PROCESS | 2429 | RSS: Main: 347340800 13:13:49 INFO - PROCESS | 2429 | 13:16:52 INFO - PROCESS | 2429 | Cycle 1(1): loaded http://localhost:52184/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52184/tests/dromaeo/cssquery-prototype.html) 13:16:52 INFO - PROCESS | 2429 | RSS: Main: 322469888 13:16:52 INFO - PROCESS | 2429 | 13:19:56 INFO - PROCESS | 2429 | Cycle 1(1): loaded http://localhost:52184/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52184/tests/dromaeo/cssquery-yui.html) 13:19:57 INFO - PROCESS | 2429 | RSS: Main: 310902784 13:19:57 INFO - PROCESS | 2429 | 13:22:59 INFO - PROCESS | 2429 | Cycle 1(1): loaded http://localhost:52184/tests/dromaeo/cssquery-yui.html (next: http://localhost:52184/tests/dromaeo/cssquery-dojo.html) 13:23:00 INFO - PROCESS | 2429 | RSS: Main: 494882816 13:23:00 INFO - PROCESS | 2429 | 13:23:00 INFO - PROCESS | 2429 | __start_tp_report 13:23:00 INFO - PROCESS | 2429 | _x_x_mozilla_page_load 13:23:00 INFO - PROCESS | 2429 | _x_x_mozilla_page_load_details 13:23:00 INFO - PROCESS | 2429 | |i|pagename|runs| 13:23:00 INFO - PROCESS | 2429 | |0;dojo.html;3212.261179928615;3212.7429805615548;3218.742500599952;3238.611366636004;3267.6568960259174;5340.732963351837;5436.2661040759485;5446.128619420893;5455.454454554542;5493.587980901433;5529.447055294479;5562.888742225153;5565.749541270652;5568.86077848054;5575.470330318623;5006.549410553059;5016.673916195454;5037.2192310191795;5119.744012799364;5142.717150556718;5050.671706339094;5063.240513922922;5068.873278168038;5089.3129427527365;5159.277701121846;4345.41336919515;5072.543471087602;5097.260897169908;5106.157484015133;5109.2591574221715;5119.795208191668;5145.691258524501;5169.56058735008;5187.066328060948;5226.477352264743;4902.3626928499425;5069.340985671876;5093.1087059764395;5098.898022039539;5113.948860511422;4967.931894642633;5488.7530061147345;5503;5515.779368825242;5555.416681248492;6043;6065.60573562717;6087.969560152215;6122.724477398528;6131.96934015327;6219.40915613016;6223.346548612376;6234;6241.531885108635;6290.654014029226;5485.341758988947;5520.944790552083;5565.833025009256;5580.748866301026;5594.049011668027;6144.556029333103;6145.4161854623735;6153.107799369066;6164.291106522807;6175.104609831639;5835.620684655484;5837.67892765902;5851.561132915049;5861.5603829712945;5864.736086876101;6028.09578563219;6061.878762424815;6081.057436097412;6093.421124993119;6121.265448146162;6038.154658347835;6110.558759196641;6130.448259656652;6135.601185922901;6136.7852125175405;5272.762725677354;5957;6043.972524670817;6116.2048933639235;6121.785737499166;4837.298591704253;4839.491853355417;4852.296417019583;4855.028994201174;4887.608991280689;4300.37644541546;4321.286987647003;4346.434963454731;4362.607365337135;4375.868723938287;5617.410171931889;5621.072523033736;5628.802991895264;5636.718164091779;5660.377358490563;5966.642001479839;5985.042393217064;6009.338972712998;6147.231596050494;6180.845478862974;5469.507744303032;5520.309961254843;5531.0873705838085;5535.750891209906;5630.324361076615;5264;5264.184051472028;5276.234945932895;5279.788808447619;5281.841544753664;6235.064740288993;6238.095476156022;6243.687815609111;6247.12540244357;6271.372862713874;5885.911711324248;6089.69551522431;6095.664738439428;6121.816345509642;6124.846878828065;6215.564910456405;6244.2819075806865;6244.375562443719;6258.968705156445;6263.718132683949;6091.451769340603;6096.664683442275;6112.047575716935;6131.233595800525;6136.171616831671;6135.110408990582;6149.169862068742;6160.260768707783;6160.969195153995;6172.4136207060255;5747.597668163188;5811.709414529341;5981.820545383645;6001.4598686116715;6026.638401695912;5872.324682661549;5909.113632955091;5909.468147866713;5982.312034115958;6035.305939816802;4714.882127946692;5834.708264586839;5850.736716847667;5860.560457965755;5875.383084776208;5034.370703662043;5807.941920580909;5989.371116032754;6005.849853753691;6017.759289628541;5662.2639056922335;5671.432856714296;5672.744726487401;5752.798652047159;5787.334456537552 13:23:00 INFO - PROCESS | 2429 | |1;ext.html;462.3827190700415;509.65088914093826;513.4095789841683;514.9340864410672;518.453032051186;29452.558211626816;31592.68407315926;31600.051998440085;31705.682943170563;39025;37659.43510847333;38815.611843881554;39131.652100873966;41121.588784112224;41176;9146.131117543822;9363.812723745521;9367.531623418836;9367.625294988193;9388.577514011851;9205.079492050809;9355.625774968994;9362.25101991839;9363.859542106873;9367.437953722765;9350.251979841596;9372.343935924488;9376.156145946863;9395.295352848563;9395.718128456123;8914.687985920495;9349.252059835197;9352.67265645699;9364.157225849673;9366.859497107549;9237.214836738885;9300.023497532797;9311.301652376098;9315.39449935752;9320.44077355354;38858.417123743166;39174.21651566981;39233.80383098095;39253;39308.80345598254;3315.5689760331;3380.9661903380897;3434.6050204226585;3805.429185622151;3860.884173474772;28111.156665300074;28229.717702822913;29571.70428295711;30318.54522182169;30491.23771905698;3132.577102091211;3157.810531368102;3164.398764234788;3221.774475786696;3245.140037889961;464706;467781;468735;468906;477736;33659.66340336614;34099.65900341015;34581;58985.705071475226;59546.40453595495;35306.470402943974;35351.82324088414;35369.115772105906;35405.46891796625;35517.82241088778;14196.935229857801;14325.35535900887;14341.211233382264;14343.56969290923;14384.496542620958;12009.279443233434;12086.637400877988;12089.214201076902;12101.152919295564;12105.939470302768;7231.421486281085;7822.413319001098;7832.295093441618;7881.684732610746;7924.445288829842;2820.7602353800157;3211.871525138968;3249.317643294887;3267.607887053521;3337.5828021497314;905.8278927003848;916.0884919505135;924.542351535994;929.6049179098856;957.8323793336139;27619;28393.858030709715;28598.428031439256;29142;29168;819.8237378963432;857.7126662567985;910.160299864414;1041.375174895072;1047.9947600262103;13286.66783330405;14956;14963.755436684585;15247.3901043957;15320.693586128215;346643;348061;348787;348977;646691;56100.71949640226;56617;56708.43291567032;56867.715661421425;56961;1224.2837939805136;1262.7853264944981;1335.1721932401779;1340.45041532971;1382.6405134664858;28580.42839143247;29598.408031839674;29676.81292748266;30233.337166456055;30315.696843031288;48574.514254857;49204;49220;49350.25974610312;49443;509050;511685.76628467964;511995;801585;814694;39360.80319598383;39861.60138398695;40113.598864010986;40222.99442513961;40342.39486407765;43322.133557328045;43435.78282108569;43505;43812.561874380845;43846.780766095966;36080;36597.268054638225;37486.812565937;38121;38639.03402414962;36701.08247293839;36810.447843281836;36942.26115477729;37346.253074937806;37774.62225377821;36352.63647363493;36888.07779805527;37069.25861482701;37091.814540927124;37284.69503567362;33015.66984330126;33562.664373355954;33707;33805.492917606745;34261.82869085639;24934.750652493243;25013.624795627715;25120;25198.24405267845;25239.242822715347 13:23:00 INFO - PROCESS | 2429 | |2;jquery.html;346.55121617505336;355.0661759572324;377.92630437064764;382.41872354021876;404.0545124408883;14004.439822407105;14849.331780069895;16940.745888811678;19268.3256086037;19745.802541974594;18206;18416.81583184168;20044.398668039947;20088.59822803543;20219.494512637193;5403.648762830413;5811.970940145294;5881.558883083764;5892.793752218673;5895;5705.543556515489;5796.24648795656;5801;6222.62664240147;6586.242582103047;6604.537682362236;6613.206415230179;6613.966930165342;6617.536772425908;6636.336366363374;6430.292667806538;6534.901976470333;6550;6612;6620.6358650274215;5710.885782284331;5798.130280457923;5848.88302233953;5851.210086638292;5853.209816674779;12817.935910320482;13063.34683265833;13194.802077968838;13231.073824832265;13263.801042984363;2138.812958807861;2257.4469255032623;2378.595638741418;2627.3825650972008;2820.9012684556146;9595.760105997337;9656.565454554562;10083.697489075339;10108.685870836818;10116.94941525295;1675.4387280261128;1829.1768704083083;1890.9905450472797;1937.3316205908939;1953.9511512212166;71628;106495.46752266189;107044.46477767639;107327;108130;9639.373440726331;10971.945140274247;11405.657830265105;11527.827082593767;11705.122115841346;12755.553555625695;13426.798598020841;13452;13845.16928984264;13856;7253.238409966983;7674.731384401631;7761.61191940412;7929.603519824101;8453.53505557188;8079.47483413588;8158.877616835753;8185.918140818516;8261.8347633047;8282.668693252203;4149.958500415018;4400;4518.864434066983;4526.547345265513;4628.166929952641;1744.6838706625304;1810.3392261824602;1814.3468351393487;1821.4080423862297;1830.2313028528051;871.7515508080166;907.8955920069144;928.5960607135918;952.6665667016628;988.7626969527262;17687;20158.89126098079;20978;21016.78983210179;21125.049372778263;869.826034793044;914.1589737441569;945.7588314979636;954.236610711428;970.0638883477478;8326.70856520019;10384.480775961172;10994.945025274823;11067.667969960914;11099.778004439866;594530;595379;606403;612995;620139;112084.43957780159;112588;113019;117415;120863.39568302102;869.5000374784524;898.070497035565;915.6474757218385;919.1589695428607;919.6045700348914;14136.929315353358;17829.643407132044;18124.909375453037;18369.54076148107;18449.723254151468;37076;48818.75590622024;48828.826126301676;50055.998880022926;50390;70527;72509;72700;74095;74605;6989.790306290819;7900.84198316042;8001.959990200012;8133.349332053303;8308.29379502749;10321;10517.9474102629;12714.809277860655;12778.936105319413;12859.421326040163;10797.352158870493;10803.351798892092;10908.509117089592;10971.122310215324;11243.4378281084;8562.186592273723;10511.842322365324;10747.570097196025;10957.232993690684;11027.83458248143;11008;11224.831627525757;11501.964823165621;11726.94136529346;11828.994535464582;7967;7992.200779921961;8345.248927596545;8493.957530212308;8507.191816777397;9558.845580958407;11023.779524409307;11096.778064438504;11334.489947952197;11349.943250283695 13:23:00 INFO - PROCESS | 2429 | |3;mootools.html;1379.5378548186359;1388.9583312500622;1474.98963210201;1718.2267979409253;1783.9018853963034;7313.817154571138;7769.106552746436;7992.960035199823;8420.452670576407;8440.366972477066;6611.371919667624;7656.732014379498;7706.306432421081;7735.4585179037485;8126.106128325894;2304.2626359564906;2340.8946597403074;2341.1922886604093;2342.2387723989686;2346.155384061745;2336.5910965581043;2359.7876191142796;2381.785639292463;2385.666006759055;2390.2351247600773;2316.536692661466;2324.535092981402;2340.2862127051244;2352.5647755165264;2355.717313922332;2090.237063471822;2186.2348178137686;2309.58427483053;2330.265966220635;2333.9766602334016;2343.6250199968094;2353.8116950643907;2359.044586942274;2359.3629719975684;2360.4570948681726;7285.854282914365;8353.916460835375;8360.45657032291;8369.790755231106;8385.119562445978;5027.874303142414;5191.974040129775;5192.740362981874;5197.870053248661;5229.137192363255;3306.504024396336;3386.153461634591;3531.841067151984;3576.1059735066233;3576.302620988908;1052.7253119094507;1062.4634559547455;1083.182197440935;1088.678839742278;1103.0128035408266;10705.357678539234;10810.621628243052;10814.405207713573;10820.72948176294;10862.511186996604;4106.67146628275;4599;4679.859604211879;4688.695234809727;4737.431508218967;9282;9285.164335209864;9304;9316.813663726687;9321.394109383004;5148.202028685485;5160.587153027749;5163.483651634807;5164.096283150434;5177.844664660066;3801.733878628525;4192.371144328315;4358.080086342158;4700.08348372071;4709.95290047102;3777.773333599993;3788.6021967693546;3876.2053778975805;3892.0853599404118;3909.3745000799736;1260.470602346998;1263.943122559487;1266.8289780879463;1279.2836011833404;1279.6161151654653;749.7713197474714;847.9406441549032;895.0870112485229;896.1799953042893;897.6499165325529;5442.91835622466;5529.474699903502;5532.944670553324;5812.709364531756;5818.21454103699;917.7797328641078;949.7862980829397;958.4393130018877;1008.4655132779639;1018.9082982531608;3601.9099522511624;3705.5923848376656;3732.9066773330883;3786.7159963002887;3812.504374431306;9768.07203315684;10211.693649190536;10229;10281.228907831943;10282.588696452207;9187.310951678652;10009;10146.949265253774;10160.949195254125;10163.983601639777;7588.317051465284;7778.922210777933;7795.844083118306;7807.453478256468;7809.375249980101;5640.915386269291;5661;5672.659640421588;5752.68360240174;5840.386759390372;9402.43585384879;9402.57688404037;9415.57629906642;9433.622655093719;9466.574004169692;9403;9528.761780955532;9580.18568421692;9717.12545870875;9726.124648781644;6426;6492.935070649422;6837.487188460985;6842.897356539556;7133.037039999534;7810.6485208166905;7878;7948.046234451903;7962.761117166494;7981.321587665114;7057.082579264663;7140.6072666003865;7150.177729560959;7241.275872412716;7295.7081716732855;6530.9673451634335;6980.546264492792;7012.719491220294;7059.563821233576;7143.785686429415;6621.404073633396;6640.568363056386;6716.798496045127;6737.966310168418;6747.898781518379;4795.376601041842;4812.25410061441;4848.466668666373;4861.343718597944;4881.29221262922;4759.095771803346;4785.162596545661;4840.201366774443;4963.03220871941;4984.22744474607 13:23:00 INFO - PROCESS | 2429 | |4;prototype.html;267.27568289934277;299.835090700115;308.73757306289656;311.15676516639905;313.21695760598504;4382.764789957121;5176.922346164811;5232.058229518685;5242.501962313584;5281.313429254201;4115.691323150761;4211.620954114129;4379.9926017016105;4961.776720047597;5157.742112894359;3015.9396812063746;3351.262722201112;3981.9203615927663;3999.540052893911;4001.2397644447606;3386.9491957620658;3520.5775306963073;3959.4258832469272;3969.078342854868;4021.256067627484;3277.44321447313;3532.876349327774;3760.856311902217;3945.782981935992;3992.9236796865757;3474.3051389721904;3493.8602455901732;3907.609239076098;3928.9214215715524;3931.7444366116397;3412.215190506173;3440.9311813763834;3441.4321636929876;3445.448728203475;3458.602260739997;4992.750362481861;5012.348394708701;5014.749262536895;5027.924581131286;5028.673136246132;3637.6726094651344;3981.0047488127966;4261.914761704748;4281.7002809803325;4533.659975501851;5122.871928201825;5378.300820893298;5402.703351195724;5420.376656684492;5447.412479072448;3777.7355585109053;3780.621937806225;3810.8285127169065;3811.428285757131;3841.308564458396;4632.2819962905805;5380.354357477049;5534.667919924817;5582.469665381823;5585.2459917910965;3871.5741268460447;3878.2631300053463;3891.494105766232;3893.5717071122153;3909.179072394772;3358.7145092667397;3381.4758712399616;3911.8630847920185;3940.995046263242;3970.5433875104154;3955.129871428281;4026.7986600670433;4408.426904502394;4536.637069034536;4546.454425468899;5417.783288668409;5423.755930983037;5424;5436.755346009439;5437.32033495813;1114.8962527098115;1141.9143564232716;1297.8312819333614;1304.7716649586284;1324.7019420630281;758.4577027425418;798.0861913109458;843;867.8784970104191;904.2675432899373;4508.7826286902355;4515.909681806345;4758.857234282977;4790.5448982346625;4820.805898868008;4536.183486972311;4841.031793641286;5113.548354860454;5173.844784656466;5295.814646487354;3944.7968369647533;4347.391365208873;4519.502854685982;4612.7001744886475;4754.358161648133;2463.97536024641;2759.4271265378543;2767.557190849495;2780.3883145707914;2789.707080756532;4875;5063.392392912874;5097.388313402415;5450.8909821803345;5457.8071827981075;4492.258777301774;4687.273472611751;5085.923711144262;5212.635115541876;5762.596618236767;5593.412691667398;5835.9708201458725;5875.911861321998;5883.882322353529;5897.616654917502;5203.27154198405;5232.110541207928;5246.921296180637;5449.291592093003;5596.384397716167;4750.762461876961;5184.533391994739;5256.710880901587;5487.283794521737;5579.497845193952;5077.746112694276;5592.972035139798;5799.246098007232;5811.506021988178;5821.825345239649;3639.253952939694;3681.8527258909344;3781.640744129303;3800.486934263839;3939.4681717968856;5534.750936207961;5598.664080155204;5627.352854421794;5643.88712225745;5668.348139963957;5145.768440420265;5175.179527157633;5478.397376288525;5505.807296744595;5514;4680.368150299802;4878.365812444359;5462.317210348707;5491.835244942658;5513.228148059195;4409.911801764011;4557.9516711157285;4839.806407743651;5281.181416880389;5405.594580406564;4602.608778253886;5273.49705333978;5385;5447;5519.647686316878;4894;5160.48395160496;5219.582433405242;5354.760369976108;5409.376452420494 13:23:00 INFO - PROCESS | 2429 | |5;yui.html;665.5075244319203;680.751525693122;756.0889128600036;767.2165877176053;795.1849354411723;13508.797368039488;13798.862011379895;14116;14298.213598252092;14508.709825803478;12870.420831062602;12951.41718622662;12961.41673624689;12990.28553429561;13015.544455944044;800.519688187089;803.9598020099;813.6379311206515;818.938579606529;819.4468733604823;822.2722890242148;825.4675734151468;825.7852958230873;826;827.3918669777709;864.9437786543855;865.1391865094208;866.2896424931558;866.679328648401;866.8179682266732;857.1514200941086;860.4579115157411;860.5052095045343;861.6036623153357;861.8060936289285;640.0335493404992;640.1326202994968;640.727690731442;641.0224407778129;641.333013665787;13844.30778461073;13933;13991.230482323468;14079;14113.85886141146;13082.432803414129;13115;13135.540256091086;13161;13650.522231721941;10590.629327973562;11116.110711143088;11270.32378057311;11350.659480215607;11467.598634047768;3415.8121303328307;3502.08945674124;3591.7665351752053;3702.2965636528975;3702.555693316819;87164.5641771787;87734;87996;92123;92326.5383673084;10037.197024238043;10252.897471025344;10279.900241447564;10371.170306375623;10428.165746740242;19877.801221987884;20016.399508014783;20053.29813456522;20138.19447222124;20274.189032438833;7422.1835598085245;7443.851122977619;7477.476576639692;7504;7597.050368703912;3642.4718415829557;3749.531308586427;4221.2190744712325;4228.703990720682;4232.407462955127;3376.6623337666038;3506.579210494757;3648.835802388899;3818.9427158592644;3818.9427158592644;693.5180049865396;700.1213477086326;711.6050591921534;713.7430525010992;718.1669263654136;581.1921429213397;645.3997782062727;648.9318621544764;656.0618315808345;657.1653999420804;8863.423877447945;9007.684731034382;9102.590383432762;9130.26957843371;9178.21985131258;619.9101130336076;655.2824657000576;655.7147640776277;656.3862788292961;667.5847203927607;4363.716358436755;4416.337549367557;4698.553637404441;4752.643551733634;4922.212446008693;106703.46648266709;112762.87237127688;117048;119682;120129;38386.27261773227;58072;64653;65417.345826541125;65861.01208481877;70026.59946801138;86749.69875451746;87662.56168719116;90329.54835225914;91746;9431.151196392357;9573.138417542455;9601.423914565148;9705.9029409705;9744.805103897741;52486.737566311924;53263.733681331345;54519.81920723127;55575;56758.71620641871;65387;65997.01004485032;66586.66826663536;66792.33207668056;75164.2483575179;12138.514459421523;12264.202826816228;12328.161846841256;12456.31490268044;13057.869421306046;13965.930170349084;13979.181839350435;13990.790138148139;14141.717165656835;14425.35085921157;12092.939535302266;12640.367981600699;13083.345832708135;13236.896169209556;14042.648933776738;12862.549810756578;12984.350782461028;13193.60419187426;13199.538016169388;13760.17438953666;10648.946755266174;12320.630381088582;12485.500579976699;12827.679308017374;12854.057666698434;10270.33242839213;10510.264281500527;10765.407902565434;11171.385573793194;11749;11105.444727763741;11117.610883619034;11269.211155219056;11376.943115284701;11381.487833047699 13:23:00 INFO - PROCESS | 2429 | __end_tp_report 13:23:00 INFO - PROCESS | 2429 | __start_cc_report 13:23:00 INFO - PROCESS | 2429 | _x_x_mozilla_cycle_collect,1544 13:23:00 INFO - PROCESS | 2429 | __end_cc_report 13:23:00 INFO - PROCESS | 2429 | __startTimestamp1483996980094__endTimestamp 13:23:00 INFO - PROCESS | 2429 | 13:23:00 INFO - PROCESS | 2429 | ------- Summary: start ------- 13:23:00 INFO - PROCESS | 2429 | Number of tests: 6 13:23:00 INFO - PROCESS | 2429 | 13:23:00 INFO - PROCESS | 2429 | [#0] dojo.html Cycles:165 Average:5588.38 Median:5752.80 stddev:647.20 (11.3%) stddev-sans-first:621.77 13:23:00 INFO - PROCESS | 2429 | Values: 3212.3 3212.7 3218.7 3238.6 3267.7 5340.7 5436.3 5446.1 5455.5 5493.6 5529.4 5562.9 5565.7 5568.9 5575.5 5006.5 5016.7 5037.2 5119.7 5142.7 5050.7 5063.2 5068.9 5089.3 5159.3 4345.4 5072.5 5097.3 5106.2 5109.3 5119.8 5145.7 5169.6 5187.1 5226.5 4902.4 5069.3 5093.1 5098.9 5113.9 4967.9 5488.8 5503.0 5515.8 5555.4 6043.0 6065.6 6088.0 6122.7 6132.0 6219.4 6223.3 6234.0 6241.5 6290.7 5485.3 5520.9 5565.8 5580.7 5594.0 6144.6 6145.4 6153.1 6164.3 6175.1 5835.6 5837.7 5851.6 5861.6 5864.7 6028.1 6061.9 6081.1 6093.4 6121.3 6038.2 6110.6 6130.4 6135.6 6136.8 5272.8 5957.0 6044.0 6116.2 6121.8 4837.3 4839.5 4852.3 4855.0 4887.6 4300.4 4321.3 4346.4 4362.6 4375.9 5617.4 5621.1 5628.8 5636.7 5660.4 5966.6 5985.0 6009.3 6147.2 6180.8 5469.5 5520.3 5531.1 5535.8 5630.3 5264.0 5264.2 5276.2 5279.8 5281.8 6235.1 6238.1 6243.7 6247.1 6271.4 5885.9 6089.7 6095.7 6121.8 6124.8 6215.6 6244.3 6244.4 6259.0 6263.7 6091.5 6096.7 6112.0 6131.2 6136.2 6135.1 6149.2 6160.3 6161.0 6172.4 5747.6 5811.7 5981.8 6001.5 6026.6 5872.3 5909.1 5909.5 5982.3 6035.3 4714.9 5834.7 5850.7 5860.6 5875.4 5034.4 5807.9 5989.4 6005.8 6017.8 5662.3 5671.4 5672.7 5752.8 5787.3 13:23:00 INFO - PROCESS | 2429 | 13:23:00 INFO - PROCESS | 2429 | [#1] ext.html Cycles:180 Average:62624.27 Median:20963.21 stddev:140233.44 (669.0%) stddev-sans-first:140549.16 13:23:00 INFO - PROCESS | 2429 | Values: 462.4 509.7 513.4 514.9 518.5 29452.6 31592.7 31600.1 31705.7 39025.0 37659.4 38815.6 39131.7 41121.6 41176.0 9146.1 9363.8 9367.5 9367.6 9388.6 9205.1 9355.6 9362.3 9363.9 9367.4 9350.3 9372.3 9376.2 9395.3 9395.7 8914.7 9349.3 9352.7 9364.2 9366.9 9237.2 9300.0 9311.3 9315.4 9320.4 38858.4 39174.2 39233.8 39253.0 39308.8 3315.6 3381.0 3434.6 3805.4 3860.9 28111.2 28229.7 29571.7 30318.5 30491.2 3132.6 3157.8 3164.4 3221.8 3245.1 464706.0 467781.0 468735.0 468906.0 477736.0 33659.7 34099.7 34581.0 58985.7 59546.4 35306.5 35351.8 35369.1 35405.5 35517.8 14196.9 14325.4 14341.2 14343.6 14384.5 12009.3 12086.6 12089.2 12101.2 12105.9 7231.4 7822.4 7832.3 7881.7 7924.4 2820.8 3211.9 3249.3 3267.6 3337.6 905.8 916.1 924.5 929.6 957.8 27619.0 28393.9 28598.4 29142.0 29168.0 819.8 857.7 910.2 1041.4 1048.0 13286.7 14956.0 14963.8 15247.4 15320.7 346643.0 348061.0 348787.0 348977.0 646691.0 56100.7 56617.0 56708.4 56867.7 56961.0 1224.3 1262.8 1335.2 1340.5 1382.6 28580.4 29598.4 29676.8 30233.3 30315.7 48574.5 49204.0 49220.0 49350.3 49443.0 509050.0 511685.8 511995.0 801585.0 814694.0 39360.8 39861.6 40113.6 40223.0 40342.4 43322.1 43435.8 43505.0 43812.6 43846.8 36080.0 36597.3 37486.8 38121.0 38639.0 36701.1 36810.4 36942.3 37346.3 37774.6 36352.6 36888.1 37069.3 37091.8 37284.7 33015.7 33562.7 33707.0 33805.5 34261.8 24934.8 25013.6 25120.0 25198.2 25239.2 13:23:00 INFO - PROCESS | 2429 | 13:23:00 INFO - PROCESS | 2429 | [#2] jquery.html Cycles:180 Average:33473.86 Median:18726.96 stddev:100431.36 (536.3%) stddev-sans-first:100682.29 13:23:00 INFO - PROCESS | 2429 | Values: 346.6 355.1 377.9 382.4 404.1 14004.4 14849.3 16940.7 19268.3 19745.8 18206.0 18416.8 20044.4 20088.6 20219.5 5403.6 5812.0 5881.6 5892.8 5895.0 5705.5 5796.2 5801.0 6222.6 6586.2 6604.5 6613.2 6614.0 6617.5 6636.3 6430.3 6534.9 6550.0 6612.0 6620.6 5710.9 5798.1 5848.9 5851.2 5853.2 12817.9 13063.3 13194.8 13231.1 13263.8 2138.8 2257.4 2378.6 2627.4 2820.9 9595.8 9656.6 10083.7 10108.7 10116.9 1675.4 1829.2 1891.0 1937.3 1954.0 71628.0 106495.5 107044.5 107327.0 108130.0 9639.4 10971.9 11405.7 11527.8 11705.1 12755.6 13426.8 13452.0 13845.2 13856.0 7253.2 7674.7 7761.6 7929.6 8453.5 8079.5 8158.9 8185.9 8261.8 8282.7 4150.0 4400.0 4518.9 4526.5 4628.2 1744.7 1810.3 1814.3 1821.4 1830.2 871.8 907.9 928.6 952.7 988.8 17687.0 20158.9 20978.0 21016.8 21125.0 869.8 914.2 945.8 954.2 970.1 8326.7 10384.5 10994.9 11067.7 11099.8 594530.0 595379.0 606403.0 612995.0 620139.0 112084.4 112588.0 113019.0 117415.0 120863.4 869.5 898.1 915.6 919.2 919.6 14136.9 17829.6 18124.9 18369.5 18449.7 37076.0 48818.8 48828.8 50056.0 50390.0 70527.0 72509.0 72700.0 74095.0 74605.0 6989.8 7900.8 8002.0 8133.3 8308.3 10321.0 10517.9 12714.8 12778.9 12859.4 10797.4 10803.4 10908.5 10971.1 11243.4 8562.2 10511.8 10747.6 10957.2 11027.8 11008.0 11224.8 11502.0 11726.9 11829.0 7967.0 7992.2 8345.2 8494.0 8507.2 9558.8 11023.8 11096.8 11334.5 11349.9 13:23:00 INFO - PROCESS | 2429 | 13:23:00 INFO - PROCESS | 2429 | [#3] mootools.html Cycles:180 Average:5412.95 Median:5088.04 stddev:2951.92 (58.0%) stddev-sans-first:2944.63 13:23:00 INFO - PROCESS | 2429 | Values: 1379.5 1389.0 1475.0 1718.2 1783.9 7313.8 7769.1 7993.0 8420.5 8440.4 6611.4 7656.7 7706.3 7735.5 8126.1 2304.3 2340.9 2341.2 2342.2 2346.2 2336.6 2359.8 2381.8 2385.7 2390.2 2316.5 2324.5 2340.3 2352.6 2355.7 2090.2 2186.2 2309.6 2330.3 2334.0 2343.6 2353.8 2359.0 2359.4 2360.5 7285.9 8353.9 8360.5 8369.8 8385.1 5027.9 5192.0 5192.7 5197.9 5229.1 3306.5 3386.2 3531.8 3576.1 3576.3 1052.7 1062.5 1083.2 1088.7 1103.0 10705.4 10810.6 10814.4 10820.7 10862.5 4106.7 4599.0 4679.9 4688.7 4737.4 9282.0 9285.2 9304.0 9316.8 9321.4 5148.2 5160.6 5163.5 5164.1 5177.8 3801.7 4192.4 4358.1 4700.1 4710.0 3777.8 3788.6 3876.2 3892.1 3909.4 1260.5 1263.9 1266.8 1279.3 1279.6 749.8 847.9 895.1 896.2 897.6 5442.9 5529.5 5532.9 5812.7 5818.2 917.8 949.8 958.4 1008.5 1018.9 3601.9 3705.6 3732.9 3786.7 3812.5 9768.1 10211.7 10229.0 10281.2 10282.6 9187.3 10009.0 10146.9 10160.9 10164.0 7588.3 7778.9 7795.8 7807.5 7809.4 5640.9 5661.0 5672.7 5752.7 5840.4 9402.4 9402.6 9415.6 9433.6 9466.6 9403.0 9528.8 9580.2 9717.1 9726.1 6426.0 6492.9 6837.5 6842.9 7133.0 7810.6 7878.0 7948.0 7962.8 7981.3 7057.1 7140.6 7150.2 7241.3 7295.7 6531.0 6980.5 7012.7 7059.6 7143.8 6621.4 6640.6 6716.8 6738.0 6747.9 4795.4 4812.3 4848.5 4861.3 4881.3 4759.1 4785.2 4840.2 4963.0 4984.2 13:23:00 INFO - PROCESS | 2429 | 13:23:00 INFO - PROCESS | 2429 | [#4] prototype.html Cycles:180 Average:4325.17 Median:4774.70 stddev:1332.92 (27.9%) stddev-sans-first:1301.40 13:23:00 INFO - PROCESS | 2429 | Values: 267.3 299.8 308.7 311.2 313.2 4382.8 5176.9 5232.1 5242.5 5281.3 4115.7 4211.6 4380.0 4961.8 5157.7 3015.9 3351.3 3981.9 3999.5 4001.2 3386.9 3520.6 3959.4 3969.1 4021.3 3277.4 3532.9 3760.9 3945.8 3992.9 3474.3 3493.9 3907.6 3928.9 3931.7 3412.2 3440.9 3441.4 3445.4 3458.6 4992.8 5012.3 5014.7 5027.9 5028.7 3637.7 3981.0 4261.9 4281.7 4533.7 5122.9 5378.3 5402.7 5420.4 5447.4 3777.7 3780.6 3810.8 3811.4 3841.3 4632.3 5380.4 5534.7 5582.5 5585.2 3871.6 3878.3 3891.5 3893.6 3909.2 3358.7 3381.5 3911.9 3941.0 3970.5 3955.1 4026.8 4408.4 4536.6 4546.5 5417.8 5423.8 5424.0 5436.8 5437.3 1114.9 1141.9 1297.8 1304.8 1324.7 758.5 798.1 843.0 867.9 904.3 4508.8 4515.9 4758.9 4790.5 4820.8 4536.2 4841.0 5113.5 5173.8 5295.8 3944.8 4347.4 4519.5 4612.7 4754.4 2464.0 2759.4 2767.6 2780.4 2789.7 4875.0 5063.4 5097.4 5450.9 5457.8 4492.3 4687.3 5085.9 5212.6 5762.6 5593.4 5836.0 5875.9 5883.9 5897.6 5203.3 5232.1 5246.9 5449.3 5596.4 4750.8 5184.5 5256.7 5487.3 5579.5 5077.7 5593.0 5799.2 5811.5 5821.8 3639.3 3681.9 3781.6 3800.5 3939.5 5534.8 5598.7 5627.4 5643.9 5668.3 5145.8 5175.2 5478.4 5505.8 5514.0 4680.4 4878.4 5462.3 5491.8 5513.2 4409.9 4558.0 4839.8 5281.2 5405.6 4602.6 5273.5 5385.0 5447.0 5519.6 4894.0 5160.5 5219.6 5354.8 5409.4 13:23:00 INFO - PROCESS | 2429 | 13:23:00 INFO - PROCESS | 2429 | [#5] yui.html Cycles:180 Average:19517.85 Median:4298.06 stddev:28385.93 (660.4%) stddev-sans-first:28430.27 13:23:00 INFO - PROCESS | 2429 | Values: 665.5 680.8 756.1 767.2 795.2 13508.8 13798.9 14116.0 14298.2 14508.7 12870.4 12951.4 12961.4 12990.3 13015.5 800.5 804.0 813.6 818.9 819.4 822.3 825.5 825.8 826.0 827.4 864.9 865.1 866.3 866.7 866.8 857.2 860.5 860.5 861.6 861.8 640.0 640.1 640.7 641.0 641.3 13844.3 13933.0 13991.2 14079.0 14113.9 13082.4 13115.0 13135.5 13161.0 13650.5 10590.6 11116.1 11270.3 11350.7 11467.6 3415.8 3502.1 3591.8 3702.3 3702.6 87164.6 87734.0 87996.0 92123.0 92326.5 10037.2 10252.9 10279.9 10371.2 10428.2 19877.8 20016.4 20053.3 20138.2 20274.2 7422.2 7443.9 7477.5 7504.0 7597.1 3642.5 3749.5 4221.2 4228.7 4232.4 3376.7 3506.6 3648.8 3818.9 3818.9 693.5 700.1 711.6 713.7 718.2 581.2 645.4 648.9 656.1 657.2 8863.4 9007.7 9102.6 9130.3 9178.2 619.9 655.3 655.7 656.4 667.6 4363.7 4416.3 4698.6 4752.6 4922.2 106703.5 112762.9 117048.0 119682.0 120129.0 38386.3 58072.0 64653.0 65417.3 65861.0 70026.6 86749.7 87662.6 90329.5 91746.0 9431.2 9573.1 9601.4 9705.9 9744.8 52486.7 53263.7 54519.8 55575.0 56758.7 65387.0 65997.0 66586.7 66792.3 75164.2 12138.5 12264.2 12328.2 12456.3 13057.9 13965.9 13979.2 13990.8 14141.7 14425.4 12092.9 12640.4 13083.3 13236.9 14042.6 12862.5 12984.4 13193.6 13199.5 13760.2 10648.9 12320.6 12485.5 12827.7 12854.1 10270.3 10510.3 10765.4 11171.4 11749.0 11105.4 11117.6 11269.2 11376.9 11381.5 13:23:00 INFO - PROCESS | 2429 | -------- Summary: end -------- 13:23:00 INFO - PROCESS | 2429 | 13:23:00 INFO - TEST-INFO | 2429: exit 0 13:23:00 INFO - TEST-OK | dromaeo_css | took 1119704ms 13:23:00 INFO - TEST-START | kraken 13:23:00 INFO - operating with platform_type : mac_ 13:23:00 INFO - Initialising browser for kraken test... 13:23:00 INFO - TEST-INFO | started process 2546 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpi0zSKD/profile http://localhost:52184/getInfo.html) 13:23:03 INFO - PROCESS | 2546 | __metrics Screen width/height:1600/1200 13:23:03 INFO - PROCESS | 2546 | colorDepth:24 13:23:03 INFO - PROCESS | 2546 | Browser inner width/height: 1024/689 13:23:03 INFO - PROCESS | 2546 | __metrics 13:23:03 INFO - PROCESS | 2546 | 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" 13:23:03 INFO - PROCESS | 2546 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:23:04 INFO - TEST-INFO | 2546: exit 0 13:23:04 INFO - Browser initialized. 13:23:04 INFO - Running cycle 1/1 for kraken test... 13:23:04 INFO - TEST-INFO | started process 2547 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpi0zSKD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:23:16 INFO - PROCESS | 2547 | RSS: Main: 223031296 13:23:16 INFO - PROCESS | 2547 | 13:23:19 INFO - PROCESS | 2547 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52184/tests/kraken/driver.html?testName=audio-beat-detection) 13:23:20 INFO - PROCESS | 2547 | RSS: Main: 272781312 13:23:20 INFO - PROCESS | 2547 | 13:23:22 INFO - PROCESS | 2547 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52184/tests/kraken/driver.html?testName=audio-dft) 13:23:23 INFO - PROCESS | 2547 | RSS: Main: 284565504 13:23:23 INFO - PROCESS | 2547 | 13:23:26 INFO - PROCESS | 2547 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52184/tests/kraken/driver.html?testName=audio-fft) 13:23:27 INFO - PROCESS | 2547 | RSS: Main: 382279680 13:23:27 INFO - PROCESS | 2547 | 13:23:29 INFO - PROCESS | 2547 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52184/tests/kraken/driver.html?testName=audio-oscillator) 13:23:29 INFO - PROCESS | 2547 | RSS: Main: 283676672 13:23:29 INFO - PROCESS | 2547 | 13:23:31 INFO - PROCESS | 2547 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52184/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:23:32 INFO - PROCESS | 2547 | RSS: Main: 285052928 13:23:32 INFO - PROCESS | 2547 | 13:23:35 INFO - PROCESS | 2547 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52184/tests/kraken/driver.html?testName=imaging-darkroom) 13:23:35 INFO - PROCESS | 2547 | RSS: Main: 325668864 13:23:35 INFO - PROCESS | 2547 | 13:23:38 INFO - PROCESS | 2547 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52184/tests/kraken/driver.html?testName=imaging-desaturate) 13:23:39 INFO - PROCESS | 2547 | RSS: Main: 326242304 13:23:39 INFO - PROCESS | 2547 | 13:23:42 INFO - PROCESS | 2547 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52184/tests/kraken/driver.html?testName=json-parse-financial) 13:23:42 INFO - PROCESS | 2547 | RSS: Main: 323903488 13:23:42 INFO - PROCESS | 2547 | 13:23:44 INFO - PROCESS | 2547 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52184/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:23:44 INFO - PROCESS | 2547 | RSS: Main: 299827200 13:23:44 INFO - PROCESS | 2547 | 13:23:46 INFO - PROCESS | 2547 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:23:47 INFO - PROCESS | 2547 | RSS: Main: 299913216 13:23:47 INFO - PROCESS | 2547 | 13:23:49 INFO - PROCESS | 2547 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:23:50 INFO - PROCESS | 2547 | RSS: Main: 303022080 13:23:50 INFO - PROCESS | 2547 | 13:23:53 INFO - PROCESS | 2547 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:23:54 INFO - PROCESS | 2547 | RSS: Main: 315117568 13:23:54 INFO - PROCESS | 2547 | 13:23:56 INFO - PROCESS | 2547 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:23:57 INFO - PROCESS | 2547 | RSS: Main: 315293696 13:23:57 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52184/tests/kraken/driver.html?testName=ai-astar) 13:23:59 INFO - PROCESS | 2547 | RSS: Main: 359284736 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | __start_tp_report 13:23:59 INFO - PROCESS | 2547 | _x_x_mozilla_page_load 13:23:59 INFO - PROCESS | 2547 | _x_x_mozilla_page_load_details 13:23:59 INFO - PROCESS | 2547 | |i|pagename|runs| 13:23:59 INFO - PROCESS | 2547 | |0;ai-astar;116;115;116;115;115;116;115;114;114;115 13:23:59 INFO - PROCESS | 2547 | |1;audio-beat-detection;145;110;113;145;110;111;106;104;138;109 13:23:59 INFO - PROCESS | 2547 | |2;audio-dft;183;186;183;183;183;184;182;183;183;185 13:23:59 INFO - PROCESS | 2547 | |3;audio-fft;82;62;59;91;61;59;59;58;83;58 13:23:59 INFO - PROCESS | 2547 | |4;audio-oscillator;87;71;94;71;68;70;90;67;68;92 13:23:59 INFO - PROCESS | 2547 | |5;imaging-gaussian-blur;87;84;86;85;87;83;87;84;86;88 13:23:59 INFO - PROCESS | 2547 | |6;imaging-darkroom;94;95;96;92;94;94;92;94;92;93 13:23:59 INFO - PROCESS | 2547 | |7;imaging-desaturate;86;81;79;79;81;82;102;135;122;80 13:23:59 INFO - PROCESS | 2547 | |8;json-parse-financial;56;56;54;54;57;57;57;57;58;55 13:23:59 INFO - PROCESS | 2547 | |9;json-stringify-tinderbox;65;74;70;78;74;70;71;73;72;73 13:23:59 INFO - PROCESS | 2547 | |10;stanford-crypto-aes;93;95;96;95;83;84;84;82;83;84 13:23:59 INFO - PROCESS | 2547 | |11;stanford-crypto-ccm;139;140;138;138;137;143;145;157;215;171 13:23:59 INFO - PROCESS | 2547 | |12;stanford-crypto-pbkdf2;165;165;163;166;166;164;164;163;163;164 13:23:59 INFO - PROCESS | 2547 | |13;stanford-crypto-sha256-iterative;69;69;68;69;68;67;68;66;68;67 13:23:59 INFO - PROCESS | 2547 | __end_tp_report 13:23:59 INFO - PROCESS | 2547 | __start_cc_report 13:23:59 INFO - PROCESS | 2547 | _x_x_mozilla_cycle_collect,2040 13:23:59 INFO - PROCESS | 2547 | __end_cc_report 13:23:59 INFO - PROCESS | 2547 | __startTimestamp1483997039385__endTimestamp 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | ------- Summary: start ------- 13:23:59 INFO - PROCESS | 2547 | Number of tests: 14 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 13:23:59 INFO - PROCESS | 2547 | Values: 116.0 115.0 116.0 115.0 115.0 116.0 115.0 114.0 114.0 115.0 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | [#1] audio-beat-detection Cycles:10 Average:119.10 Median:112.00 stddev:16.56 (14.8%) stddev-sans-first:14.68 13:23:59 INFO - PROCESS | 2547 | Values: 145.0 110.0 113.0 145.0 110.0 111.0 106.0 104.0 138.0 109.0 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.00 stddev:1.18 (0.6%) stddev-sans-first:1.24 13:23:59 INFO - PROCESS | 2547 | Values: 183.0 186.0 183.0 183.0 183.0 184.0 182.0 183.0 183.0 185.0 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | [#3] audio-fft Cycles:10 Average:67.20 Median:61.50 stddev:12.79 (20.8%) stddev-sans-first:12.39 13:23:59 INFO - PROCESS | 2547 | Values: 82.0 62.0 59.0 91.0 61.0 59.0 59.0 58.0 83.0 58.0 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:79.00 stddev:11.35 (14.4%) stddev-sans-first:11.54 13:23:59 INFO - PROCESS | 2547 | Values: 87.0 71.0 94.0 71.0 68.0 70.0 90.0 67.0 68.0 92.0 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:86.50 stddev:1.64 (1.9%) stddev-sans-first:1.67 13:23:59 INFO - PROCESS | 2547 | Values: 87.0 84.0 86.0 85.0 87.0 83.0 87.0 84.0 86.0 88.0 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 13:23:59 INFO - PROCESS | 2547 | Values: 94.0 95.0 96.0 92.0 94.0 94.0 92.0 94.0 92.0 93.0 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | [#7] imaging-desaturate Cycles:10 Average:92.70 Median:80.50 stddev:20.29 (25.2%) stddev-sans-first:21.37 13:23:59 INFO - PROCESS | 2547 | Values: 86.0 81.0 79.0 79.0 81.0 82.0 102.0 135.0 122.0 80.0 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:57.00 stddev:1.37 (2.4%) stddev-sans-first:1.45 13:23:59 INFO - PROCESS | 2547 | Values: 56.0 56.0 54.0 54.0 57.0 57.0 57.0 57.0 58.0 55.0 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:73.00 stddev:3.40 (4.7%) stddev-sans-first:2.49 13:23:59 INFO - PROCESS | 2547 | Values: 65.0 74.0 70.0 78.0 74.0 70.0 71.0 73.0 72.0 73.0 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:88.50 stddev:5.97 (6.7%) stddev-sans-first:6.04 13:23:59 INFO - PROCESS | 2547 | Values: 93.0 95.0 96.0 95.0 83.0 84.0 84.0 82.0 83.0 84.0 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | [#11] stanford-crypto-ccm Cycles:10 Average:152.30 Median:144.00 stddev:24.53 (17.0%) stddev-sans-first:25.54 13:23:59 INFO - PROCESS | 2547 | Values: 139.0 140.0 138.0 138.0 137.0 143.0 145.0 157.0 215.0 171.0 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:164.50 stddev:1.16 (0.7%) stddev-sans-first:1.20 13:23:59 INFO - PROCESS | 2547 | Values: 165.0 165.0 163.0 166.0 166.0 164.0 164.0 163.0 163.0 164.0 13:23:59 INFO - PROCESS | 2547 | 13:23:59 INFO - PROCESS | 2547 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 13:23:59 INFO - PROCESS | 2547 | Values: 69.0 69.0 68.0 69.0 68.0 67.0 68.0 66.0 68.0 67.0 13:23:59 INFO - PROCESS | 2547 | -------- Summary: end -------- 13:23:59 INFO - PROCESS | 2547 | 13:24:00 INFO - TEST-INFO | 2547: exit 0 13:24:00 INFO - TEST-OK | kraken | took 59718ms 13:24:00 INFO - SUITE-END | took 1179s 13:24:00 INFO - Completed test suite (00:19:39) 13:24:00 INFO - javascript benchmark 13:24:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3212.261179928615, 3212.7429805615548, 3218.742500599952, 3238.611366636004, 3267.6568960259174, 5340.732963351837, 5436.2661040759485, 5446.128619420893, 5455.454454554542, 5493.587980901433, 5529.447055294479, 5562.888742225153, 5565.749541270652, 5568.86077848054, 5575.470330318623, 5006.549410553059, 5016.673916195454, 5037.2192310191795, 5119.744012799364, 5142.717150556718, 5050.671706339094, 5063.240513922922, 5068.873278168038, 5089.3129427527365, 5159.277701121846, 4345.41336919515, 5072.543471087602, 5097.260897169908, 5106.157484015133, 5109.2591574221715, 5119.795208191668, 5145.691258524501, 5169.56058735008, 5187.066328060948, 5226.477352264743, 4902.3626928499425, 5069.340985671876, 5093.1087059764395, 5098.898022039539, 5113.948860511422, 4967.931894642633, 5488.7530061147345, 5503.0, 5515.779368825242, 5555.416681248492, 6043.0, 6065.60573562717, 6087.969560152215, 6122.724477398528, 6131.96934015327, 6219.40915613016, 6223.346548612376, 6234.0, 6241.531885108635, 6290.654014029226, 5485.341758988947, 5520.944790552083, 5565.833025009256, 5580.748866301026, 5594.049011668027, 6144.556029333103, 6145.4161854623735, 6153.107799369066, 6164.291106522807, 6175.104609831639, 5835.620684655484, 5837.67892765902, 5851.561132915049, 5861.5603829712945, 5864.736086876101, 6028.09578563219, 6061.878762424815, 6081.057436097412, 6093.421124993119, 6121.265448146162, 6038.154658347835, 6110.558759196641, 6130.448259656652, 6135.601185922901, 6136.7852125175405, 5272.762725677354, 5957.0, 6043.972524670817, 6116.2048933639235, 6121.785737499166, 4837.298591704253, 4839.491853355417, 4852.296417019583, 4855.028994201174, 4887.608991280689, 4300.37644541546, 4321.286987647003, 4346.434963454731, 4362.607365337135, 4375.868723938287, 5617.410171931889, 5621.072523033736, 5628.802991895264, 5636.718164091779, 5660.377358490563, 5966.642001479839, 5985.042393217064, 6009.338972712998, 6147.231596050494, 6180.845478862974, 5469.507744303032, 5520.309961254843, 5531.0873705838085, 5535.750891209906, 5630.324361076615, 5264.0, 5264.184051472028, 5276.234945932895, 5279.788808447619, 5281.841544753664, 6235.064740288993, 6238.095476156022, 6243.687815609111, 6247.12540244357, 6271.372862713874, 5885.911711324248, 6089.69551522431, 6095.664738439428, 6121.816345509642, 6124.846878828065, 6215.564910456405, 6244.2819075806865, 6244.375562443719, 6258.968705156445, 6263.718132683949, 6091.451769340603, 6096.664683442275, 6112.047575716935, 6131.233595800525, 6136.171616831671, 6135.110408990582, 6149.169862068742, 6160.260768707783, 6160.969195153995, 6172.4136207060255, 5747.597668163188, 5811.709414529341, 5981.820545383645, 6001.4598686116715, 6026.638401695912, 5872.324682661549, 5909.113632955091, 5909.468147866713, 5982.312034115958, 6035.305939816802, 4714.882127946692, 5834.708264586839, 5850.736716847667, 5860.560457965755, 5875.383084776208, 5034.370703662043, 5807.941920580909, 5989.371116032754, 6005.849853753691, 6017.759289628541, 5662.2639056922335, 5671.432856714296, 5672.744726487401, 5752.798652047159, 5787.334456537552], "value": 5546.2303348156265, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [462.3827190700415, 509.65088914093826, 513.4095789841683, 514.9340864410672, 518.453032051186, 29452.558211626816, 31592.68407315926, 31600.051998440085, 31705.682943170563, 39025.0, 37659.43510847333, 38815.611843881554, 39131.652100873966, 41121.588784112224, 41176.0, 9146.131117543822, 9363.812723745521, 9367.531623418836, 9367.625294988193, 9388.577514011851, 9205.079492050809, 9355.625774968994, 9362.25101991839, 9363.859542106873, 9367.437953722765, 9350.251979841596, 9372.343935924488, 9376.156145946863, 9395.295352848563, 9395.718128456123, 8914.687985920495, 9349.252059835197, 9352.67265645699, 9364.157225849673, 9366.859497107549, 9237.214836738885, 9300.023497532797, 9311.301652376098, 9315.39449935752, 9320.44077355354, 38858.417123743166, 39174.21651566981, 39233.80383098095, 39253.0, 39308.80345598254, 3315.5689760331, 3380.9661903380897, 3434.6050204226585, 3805.429185622151, 3860.884173474772, 28111.156665300074, 28229.717702822913, 29571.70428295711, 30318.54522182169, 30491.23771905698, 3132.577102091211, 3157.810531368102, 3164.398764234788, 3221.774475786696, 3245.140037889961, 464706.0, 467781.0, 468735.0, 468906.0, 477736.0, 33659.66340336614, 34099.65900341015, 34581.0, 58985.705071475226, 59546.40453595495, 35306.470402943974, 35351.82324088414, 35369.115772105906, 35405.46891796625, 35517.82241088778, 14196.935229857801, 14325.35535900887, 14341.211233382264, 14343.56969290923, 14384.496542620958, 12009.279443233434, 12086.637400877988, 12089.214201076902, 12101.152919295564, 12105.939470302768, 7231.421486281085, 7822.413319001098, 7832.295093441618, 7881.684732610746, 7924.445288829842, 2820.7602353800157, 3211.871525138968, 3249.317643294887, 3267.607887053521, 3337.5828021497314, 905.8278927003848, 916.0884919505135, 924.542351535994, 929.6049179098856, 957.8323793336139, 27619.0, 28393.858030709715, 28598.428031439256, 29142.0, 29168.0, 819.8237378963432, 857.7126662567985, 910.160299864414, 1041.375174895072, 1047.9947600262103, 13286.66783330405, 14956.0, 14963.755436684585, 15247.3901043957, 15320.693586128215, 346643.0, 348061.0, 348787.0, 348977.0, 646691.0, 56100.71949640226, 56617.0, 56708.43291567032, 56867.715661421425, 56961.0, 1224.2837939805136, 1262.7853264944981, 1335.1721932401779, 1340.45041532971, 1382.6405134664858, 28580.42839143247, 29598.408031839674, 29676.81292748266, 30233.337166456055, 30315.696843031288, 48574.514254857, 49204.0, 49220.0, 49350.25974610312, 49443.0, 509050.0, 511685.76628467964, 511995.0, 801585.0, 814694.0, 39360.80319598383, 39861.60138398695, 40113.598864010986, 40222.99442513961, 40342.39486407765, 43322.133557328045, 43435.78282108569, 43505.0, 43812.561874380845, 43846.780766095966, 36080.0, 36597.268054638225, 37486.812565937, 38121.0, 38639.03402414962, 36701.08247293839, 36810.447843281836, 36942.26115477729, 37346.253074937806, 37774.62225377821, 36352.63647363493, 36888.07779805527, 37069.25861482701, 37091.814540927124, 37284.69503567362, 33015.66984330126, 33562.664373355954, 33707.0, 33805.492917606745, 34261.82869085639, 24934.750652493243, 25013.624795627715, 25120.0, 25198.24405267845, 25239.242822715347], "value": 17962.677801695627, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.55121617505336, 355.0661759572324, 377.92630437064764, 382.41872354021876, 404.0545124408883, 14004.439822407105, 14849.331780069895, 16940.745888811678, 19268.3256086037, 19745.802541974594, 18206.0, 18416.81583184168, 20044.398668039947, 20088.59822803543, 20219.494512637193, 5403.648762830413, 5811.970940145294, 5881.558883083764, 5892.793752218673, 5895.0, 5705.543556515489, 5796.24648795656, 5801.0, 6222.62664240147, 6586.242582103047, 6604.537682362236, 6613.206415230179, 6613.966930165342, 6617.536772425908, 6636.336366363374, 6430.292667806538, 6534.901976470333, 6550.0, 6612.0, 6620.6358650274215, 5710.885782284331, 5798.130280457923, 5848.88302233953, 5851.210086638292, 5853.209816674779, 12817.935910320482, 13063.34683265833, 13194.802077968838, 13231.073824832265, 13263.801042984363, 2138.812958807861, 2257.4469255032623, 2378.595638741418, 2627.3825650972008, 2820.9012684556146, 9595.760105997337, 9656.565454554562, 10083.697489075339, 10108.685870836818, 10116.94941525295, 1675.4387280261128, 1829.1768704083083, 1890.9905450472797, 1937.3316205908939, 1953.9511512212166, 71628.0, 106495.46752266189, 107044.46477767639, 107327.0, 108130.0, 9639.373440726331, 10971.945140274247, 11405.657830265105, 11527.827082593767, 11705.122115841346, 12755.553555625695, 13426.798598020841, 13452.0, 13845.16928984264, 13856.0, 7253.238409966983, 7674.731384401631, 7761.61191940412, 7929.603519824101, 8453.53505557188, 8079.47483413588, 8158.877616835753, 8185.918140818516, 8261.8347633047, 8282.668693252203, 4149.958500415018, 4400.0, 4518.864434066983, 4526.547345265513, 4628.166929952641, 1744.6838706625304, 1810.3392261824602, 1814.3468351393487, 1821.4080423862297, 1830.2313028528051, 871.7515508080166, 907.8955920069144, 928.5960607135918, 952.6665667016628, 988.7626969527262, 17687.0, 20158.89126098079, 20978.0, 21016.78983210179, 21125.049372778263, 869.826034793044, 914.1589737441569, 945.7588314979636, 954.236610711428, 970.0638883477478, 8326.70856520019, 10384.480775961172, 10994.945025274823, 11067.667969960914, 11099.778004439866, 594530.0, 595379.0, 606403.0, 612995.0, 620139.0, 112084.43957780159, 112588.0, 113019.0, 117415.0, 120863.39568302102, 869.5000374784524, 898.070497035565, 915.6474757218385, 919.1589695428607, 919.6045700348914, 14136.929315353358, 17829.643407132044, 18124.909375453037, 18369.54076148107, 18449.723254151468, 37076.0, 48818.75590622024, 48828.826126301676, 50055.998880022926, 50390.0, 70527.0, 72509.0, 72700.0, 74095.0, 74605.0, 6989.790306290819, 7900.84198316042, 8001.959990200012, 8133.349332053303, 8308.29379502749, 10321.0, 10517.9474102629, 12714.809277860655, 12778.936105319413, 12859.421326040163, 10797.352158870493, 10803.351798892092, 10908.509117089592, 10971.122310215324, 11243.4378281084, 8562.186592273723, 10511.842322365324, 10747.570097196025, 10957.232993690684, 11027.83458248143, 11008.0, 11224.831627525757, 11501.964823165621, 11726.94136529346, 11828.994535464582, 7967.0, 7992.200779921961, 8345.248927596545, 8493.957530212308, 8507.191816777397, 9558.845580958407, 11023.779524409307, 11096.778064438504, 11334.489947952197, 11349.943250283695], "value": 9119.685415056445, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.5378548186359, 1388.9583312500622, 1474.98963210201, 1718.2267979409253, 1783.9018853963034, 7313.817154571138, 7769.106552746436, 7992.960035199823, 8420.452670576407, 8440.366972477066, 6611.371919667624, 7656.732014379498, 7706.306432421081, 7735.4585179037485, 8126.106128325894, 2304.2626359564906, 2340.8946597403074, 2341.1922886604093, 2342.2387723989686, 2346.155384061745, 2336.5910965581043, 2359.7876191142796, 2381.785639292463, 2385.666006759055, 2390.2351247600773, 2316.536692661466, 2324.535092981402, 2340.2862127051244, 2352.5647755165264, 2355.717313922332, 2090.237063471822, 2186.2348178137686, 2309.58427483053, 2330.265966220635, 2333.9766602334016, 2343.6250199968094, 2353.8116950643907, 2359.044586942274, 2359.3629719975684, 2360.4570948681726, 7285.854282914365, 8353.916460835375, 8360.45657032291, 8369.790755231106, 8385.119562445978, 5027.874303142414, 5191.974040129775, 5192.740362981874, 5197.870053248661, 5229.137192363255, 3306.504024396336, 3386.153461634591, 3531.841067151984, 3576.1059735066233, 3576.302620988908, 1052.7253119094507, 1062.4634559547455, 1083.182197440935, 1088.678839742278, 1103.0128035408266, 10705.357678539234, 10810.621628243052, 10814.405207713573, 10820.72948176294, 10862.511186996604, 4106.67146628275, 4599.0, 4679.859604211879, 4688.695234809727, 4737.431508218967, 9282.0, 9285.164335209864, 9304.0, 9316.813663726687, 9321.394109383004, 5148.202028685485, 5160.587153027749, 5163.483651634807, 5164.096283150434, 5177.844664660066, 3801.733878628525, 4192.371144328315, 4358.080086342158, 4700.08348372071, 4709.95290047102, 3777.773333599993, 3788.6021967693546, 3876.2053778975805, 3892.0853599404118, 3909.3745000799736, 1260.470602346998, 1263.943122559487, 1266.8289780879463, 1279.2836011833404, 1279.6161151654653, 749.7713197474714, 847.9406441549032, 895.0870112485229, 896.1799953042893, 897.6499165325529, 5442.91835622466, 5529.474699903502, 5532.944670553324, 5812.709364531756, 5818.21454103699, 917.7797328641078, 949.7862980829397, 958.4393130018877, 1008.4655132779639, 1018.9082982531608, 3601.9099522511624, 3705.5923848376656, 3732.9066773330883, 3786.7159963002887, 3812.504374431306, 9768.07203315684, 10211.693649190536, 10229.0, 10281.228907831943, 10282.588696452207, 9187.310951678652, 10009.0, 10146.949265253774, 10160.949195254125, 10163.983601639777, 7588.317051465284, 7778.922210777933, 7795.844083118306, 7807.453478256468, 7809.375249980101, 5640.915386269291, 5661.0, 5672.659640421588, 5752.68360240174, 5840.386759390372, 9402.43585384879, 9402.57688404037, 9415.57629906642, 9433.622655093719, 9466.574004169692, 9403.0, 9528.761780955532, 9580.18568421692, 9717.12545870875, 9726.124648781644, 6426.0, 6492.935070649422, 6837.487188460985, 6842.897356539556, 7133.037039999534, 7810.6485208166905, 7878.0, 7948.046234451903, 7962.761117166494, 7981.321587665114, 7057.082579264663, 7140.6072666003865, 7150.177729560959, 7241.275872412716, 7295.7081716732855, 6530.9673451634335, 6980.546264492792, 7012.719491220294, 7059.563821233576, 7143.785686429415, 6621.404073633396, 6640.568363056386, 6716.798496045127, 6737.966310168418, 6747.898781518379, 4795.376601041842, 4812.25410061441, 4848.466668666373, 4861.343718597944, 4881.29221262922, 4759.095771803346, 4785.162596545661, 4840.201366774443, 4963.03220871941, 4984.22744474607], "value": 4404.520569922934, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.27568289934277, 299.835090700115, 308.73757306289656, 311.15676516639905, 313.21695760598504, 4382.764789957121, 5176.922346164811, 5232.058229518685, 5242.501962313584, 5281.313429254201, 4115.691323150761, 4211.620954114129, 4379.9926017016105, 4961.776720047597, 5157.742112894359, 3015.9396812063746, 3351.262722201112, 3981.9203615927663, 3999.540052893911, 4001.2397644447606, 3386.9491957620658, 3520.5775306963073, 3959.4258832469272, 3969.078342854868, 4021.256067627484, 3277.44321447313, 3532.876349327774, 3760.856311902217, 3945.782981935992, 3992.9236796865757, 3474.3051389721904, 3493.8602455901732, 3907.609239076098, 3928.9214215715524, 3931.7444366116397, 3412.215190506173, 3440.9311813763834, 3441.4321636929876, 3445.448728203475, 3458.602260739997, 4992.750362481861, 5012.348394708701, 5014.749262536895, 5027.924581131286, 5028.673136246132, 3637.6726094651344, 3981.0047488127966, 4261.914761704748, 4281.7002809803325, 4533.659975501851, 5122.871928201825, 5378.300820893298, 5402.703351195724, 5420.376656684492, 5447.412479072448, 3777.7355585109053, 3780.621937806225, 3810.8285127169065, 3811.428285757131, 3841.308564458396, 4632.2819962905805, 5380.354357477049, 5534.667919924817, 5582.469665381823, 5585.2459917910965, 3871.5741268460447, 3878.2631300053463, 3891.494105766232, 3893.5717071122153, 3909.179072394772, 3358.7145092667397, 3381.4758712399616, 3911.8630847920185, 3940.995046263242, 3970.5433875104154, 3955.129871428281, 4026.7986600670433, 4408.426904502394, 4536.637069034536, 4546.454425468899, 5417.783288668409, 5423.755930983037, 5424.0, 5436.755346009439, 5437.32033495813, 1114.8962527098115, 1141.9143564232716, 1297.8312819333614, 1304.7716649586284, 1324.7019420630281, 758.4577027425418, 798.0861913109458, 843.0, 867.8784970104191, 904.2675432899373, 4508.7826286902355, 4515.909681806345, 4758.857234282977, 4790.5448982346625, 4820.805898868008, 4536.183486972311, 4841.031793641286, 5113.548354860454, 5173.844784656466, 5295.814646487354, 3944.7968369647533, 4347.391365208873, 4519.502854685982, 4612.7001744886475, 4754.358161648133, 2463.97536024641, 2759.4271265378543, 2767.557190849495, 2780.3883145707914, 2789.707080756532, 4875.0, 5063.392392912874, 5097.388313402415, 5450.8909821803345, 5457.8071827981075, 4492.258777301774, 4687.273472611751, 5085.923711144262, 5212.635115541876, 5762.596618236767, 5593.412691667398, 5835.9708201458725, 5875.911861321998, 5883.882322353529, 5897.616654917502, 5203.27154198405, 5232.110541207928, 5246.921296180637, 5449.291592093003, 5596.384397716167, 4750.762461876961, 5184.533391994739, 5256.710880901587, 5487.283794521737, 5579.497845193952, 5077.746112694276, 5592.972035139798, 5799.246098007232, 5811.506021988178, 5821.825345239649, 3639.253952939694, 3681.8527258909344, 3781.640744129303, 3800.486934263839, 3939.4681717968856, 5534.750936207961, 5598.664080155204, 5627.352854421794, 5643.88712225745, 5668.348139963957, 5145.768440420265, 5175.179527157633, 5478.397376288525, 5505.807296744595, 5514.0, 4680.368150299802, 4878.365812444359, 5462.317210348707, 5491.835244942658, 5513.228148059195, 4409.911801764011, 4557.9516711157285, 4839.806407743651, 5281.181416880389, 5405.594580406564, 4602.608778253886, 5273.49705333978, 5385.0, 5447.0, 5519.647686316878, 4894.0, 5160.48395160496, 5219.582433405242, 5354.760369976108, 5409.376452420494], "value": 3901.618605637488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.5075244319203, 680.751525693122, 756.0889128600036, 767.2165877176053, 795.1849354411723, 13508.797368039488, 13798.862011379895, 14116.0, 14298.213598252092, 14508.709825803478, 12870.420831062602, 12951.41718622662, 12961.41673624689, 12990.28553429561, 13015.544455944044, 800.519688187089, 803.9598020099, 813.6379311206515, 818.938579606529, 819.4468733604823, 822.2722890242148, 825.4675734151468, 825.7852958230873, 826.0, 827.3918669777709, 864.9437786543855, 865.1391865094208, 866.2896424931558, 866.679328648401, 866.8179682266732, 857.1514200941086, 860.4579115157411, 860.5052095045343, 861.6036623153357, 861.8060936289285, 640.0335493404992, 640.1326202994968, 640.727690731442, 641.0224407778129, 641.333013665787, 13844.30778461073, 13933.0, 13991.230482323468, 14079.0, 14113.85886141146, 13082.432803414129, 13115.0, 13135.540256091086, 13161.0, 13650.522231721941, 10590.629327973562, 11116.110711143088, 11270.32378057311, 11350.659480215607, 11467.598634047768, 3415.8121303328307, 3502.08945674124, 3591.7665351752053, 3702.2965636528975, 3702.555693316819, 87164.5641771787, 87734.0, 87996.0, 92123.0, 92326.5383673084, 10037.197024238043, 10252.897471025344, 10279.900241447564, 10371.170306375623, 10428.165746740242, 19877.801221987884, 20016.399508014783, 20053.29813456522, 20138.19447222124, 20274.189032438833, 7422.1835598085245, 7443.851122977619, 7477.476576639692, 7504.0, 7597.050368703912, 3642.4718415829557, 3749.531308586427, 4221.2190744712325, 4228.703990720682, 4232.407462955127, 3376.6623337666038, 3506.579210494757, 3648.835802388899, 3818.9427158592644, 3818.9427158592644, 693.5180049865396, 700.1213477086326, 711.6050591921534, 713.7430525010992, 718.1669263654136, 581.1921429213397, 645.3997782062727, 648.9318621544764, 656.0618315808345, 657.1653999420804, 8863.423877447945, 9007.684731034382, 9102.590383432762, 9130.26957843371, 9178.21985131258, 619.9101130336076, 655.2824657000576, 655.7147640776277, 656.3862788292961, 667.5847203927607, 4363.716358436755, 4416.337549367557, 4698.553637404441, 4752.643551733634, 4922.212446008693, 106703.46648266709, 112762.87237127688, 117048.0, 119682.0, 120129.0, 38386.27261773227, 58072.0, 64653.0, 65417.345826541125, 65861.01208481877, 70026.59946801138, 86749.69875451746, 87662.56168719116, 90329.54835225914, 91746.0, 9431.151196392357, 9573.138417542455, 9601.423914565148, 9705.9029409705, 9744.805103897741, 52486.737566311924, 53263.733681331345, 54519.81920723127, 55575.0, 56758.71620641871, 65387.0, 65997.01004485032, 66586.66826663536, 66792.33207668056, 75164.2483575179, 12138.514459421523, 12264.202826816228, 12328.161846841256, 12456.31490268044, 13057.869421306046, 13965.930170349084, 13979.181839350435, 13990.790138148139, 14141.717165656835, 14425.35085921157, 12092.939535302266, 12640.367981600699, 13083.345832708135, 13236.896169209556, 14042.648933776738, 12862.549810756578, 12984.350782461028, 13193.60419187426, 13199.538016169388, 13760.17438953666, 10648.946755266174, 12320.630381088582, 12485.500579976699, 12827.679308017374, 12854.057666698434, 10270.33242839213, 10510.264281500527, 10765.407902565434, 11171.385573793194, 11749.0, 11105.444727763741, 11117.610883619034, 11269.211155219056, 11376.943115284701, 11381.487833047699], "value": 7200.406585266189, "unit": "score"}], "name": "dromaeo_css", "value": 6947.29530842638, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 116.0, 115.0, 115.0, 116.0, 115.0, 114.0, 114.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 113.0, 145.0, 110.0, 111.0, 106.0, 104.0, 138.0, 109.0], "value": 119.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 183.0, 183.0, 183.0, 184.0, 182.0, 183.0, 183.0, 185.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 59.0, 91.0, 61.0, 59.0, 59.0, 58.0, 83.0, 58.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 94.0, 71.0, 68.0, 70.0, 90.0, 67.0, 68.0, 92.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 85.0, 87.0, 83.0, 87.0, 84.0, 86.0, 88.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 92.0, 94.0, 94.0, 92.0, 94.0, 92.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 79.0, 79.0, 81.0, 82.0, 102.0, 135.0, 122.0, 80.0], "value": 92.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 54.0, 54.0, 57.0, 57.0, 57.0, 57.0, 58.0, 55.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 70.0, 78.0, 74.0, 70.0, 71.0, 73.0, 72.0, 73.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 96.0, 95.0, 83.0, 84.0, 84.0, 82.0, 83.0, 84.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 138.0, 138.0, 137.0, 143.0, 145.0, 157.0, 215.0, 171.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 163.0, 166.0, 166.0, 164.0, 164.0, 163.0, 163.0, 164.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 69.0, 68.0, 67.0, 68.0, 66.0, 68.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1435.2, "alertThreshold": 2.0}]} 13:24:00 INFO - Return code: 0 13:24:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:24:00 INFO - # TBPL SUCCESS # 13:24:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:24:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:24:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:24:00 INFO - 2017-01-09 13:24:00.697 screenresolution[2557:18756] starting screenresolution argv=screenresolution get 13:24:00 INFO - 2017-01-09 13:24:00.701 screenresolution[2557:18756] Display 0: 1600x1200x32@60 13:24:00 INFO - 2017-01-09 13:24:00.707 screenresolution[2558:18759] starting screenresolution argv=screenresolution list 13:24:00 INFO - Available Modes on Display 0 13:24:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:24:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:24:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:24:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:24:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:24:00 INFO - Intel Iris: 13:24:00 INFO - Chipset Model: Intel Iris 13:24:00 INFO - Type: GPU 13:24:00 INFO - Bus: Built-In 13:24:00 INFO - VRAM (Dynamic, Max): 1536 MB 13:24:00 INFO - Vendor: Intel (0x8086) 13:24:00 INFO - Device ID: 0x0a2e 13:24:00 INFO - Revision ID: 0x0009 13:24:00 INFO - Displays: 13:24:00 INFO - Display: 13:24:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:24:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:24:00 INFO - Display Serial Number: 1600x1200 60 13:24:00 INFO - Main Display: Yes 13:24:00 INFO - Mirror: Off 13:24:00 INFO - Online: Yes 13:24:00 INFO - Rotation: Supported 13:24:00 INFO - Return code: 0 13:24:00 INFO - Running post-action listener: _resource_record_post_action 13:24:00 INFO - [mozharness: 2017-01-09 21:24:00.952832Z] Finished run-tests step (success) 13:24:00 INFO - Running post-run listener: _resource_record_post_run 13:24:01 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 237568; Write bytes: 663848960; Read time: 6; Write time: 1944 13:24:01 INFO - TinderboxPrint: CPU usage
53.5% 13:24:01 INFO - TinderboxPrint: I/O read bytes / time
237,568 / 6 13:24:01 INFO - TinderboxPrint: I/O write bytes / time
663,848,960 / 1,944 13:24:01 INFO - TinderboxPrint: CPU idle
2,254.4 (46.5%) 13:24:01 INFO - TinderboxPrint: CPU system
969.8 (20.0%) 13:24:01 INFO - TinderboxPrint: CPU user
1,621.3 (33.5%) 13:24:01 INFO - TinderboxPrint: Swap in / out
348,938,240 / 0 13:24:01 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 346110464; Write bytes: 345573376; Read time: 26699; Write time: 763 13:24:01 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 237568; Write bytes: 311119872; Read time: 6; Write time: 1149 13:24:01 INFO - Running post-run listener: _upload_blobber_files 13:24:01 INFO - Blob upload gear active. 13:24:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:24:01 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 13:24:01 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'] 13:24:01 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 13:24:01 INFO - (blobuploader) - INFO - Open directory for files ... 13:24:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:24:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:24:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:24:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:24:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:24:02 INFO - (blobuploader) - INFO - Done attempting. 13:24:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:24:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:24:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:24:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:24:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:24:03 INFO - (blobuploader) - INFO - Done attempting. 13:24:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:24:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:24:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:24:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:24:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:24:07 INFO - (blobuploader) - INFO - Done attempting. 13:24:07 INFO - (blobuploader) - INFO - Iteration through files over. 13:24:07 INFO - Return code: 0 13:24:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:24:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:24:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7d731b219741f35352bbc78edab429a29468bf8595a020b643e67e85da72bc719c5bc7d0dc180be3ca232ea72b794dcf891f329d496b61488e5ea3823480929", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19c6d3b84869579a40b42bee3e0ebf17639860aba4a8bad6020cee8c018b50f6a45c858902fd664804e57de9df7462342ac2d847c0f50748f77b6b3d1d3b3fbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56763e02354003ffb266b2fe15e5dbba0da5e72ed22b2b8ba1084a0272c2c3df2baca7cb49ee0de4f9d6737dfcfa07ea69fcb4766a943a483d78f316dbe8d146"} 13:24:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:24:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:24:07 INFO - Contents: 13:24:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7d731b219741f35352bbc78edab429a29468bf8595a020b643e67e85da72bc719c5bc7d0dc180be3ca232ea72b794dcf891f329d496b61488e5ea3823480929", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19c6d3b84869579a40b42bee3e0ebf17639860aba4a8bad6020cee8c018b50f6a45c858902fd664804e57de9df7462342ac2d847c0f50748f77b6b3d1d3b3fbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56763e02354003ffb266b2fe15e5dbba0da5e72ed22b2b8ba1084a0272c2c3df2baca7cb49ee0de4f9d6737dfcfa07ea69fcb4766a943a483d78f316dbe8d146"} 13:24:07 INFO - Running post-run listener: copy_logs_to_upload_dir 13:24:07 INFO - Copying logs to upload dir... 13:24:07 INFO - mkdir: /builds/slave/test/build/upload/logs 13:24:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.741823 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-01-09 13:24:07.431492) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 13:24:07.434708) ========= 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.taeBmiTfbc/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.3sphXo7fV5/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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/e7d731b219741f35352bbc78edab429a29468bf8595a020b643e67e85da72bc719c5bc7d0dc180be3ca232ea72b794dcf891f329d496b61488e5ea3823480929", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19c6d3b84869579a40b42bee3e0ebf17639860aba4a8bad6020cee8c018b50f6a45c858902fd664804e57de9df7462342ac2d847c0f50748f77b6b3d1d3b3fbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56763e02354003ffb266b2fe15e5dbba0da5e72ed22b2b8ba1084a0272c2c3df2baca7cb49ee0de4f9d6737dfcfa07ea69fcb4766a943a483d78f316dbe8d146"} build_url:https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010534 build_url: 'https://queue.taskcluster.net/v1/task/J1lBu5KzRH63z8ZGXnormw/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/e7d731b219741f35352bbc78edab429a29468bf8595a020b643e67e85da72bc719c5bc7d0dc180be3ca232ea72b794dcf891f329d496b61488e5ea3823480929", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19c6d3b84869579a40b42bee3e0ebf17639860aba4a8bad6020cee8c018b50f6a45c858902fd664804e57de9df7462342ac2d847c0f50748f77b6b3d1d3b3fbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56763e02354003ffb266b2fe15e5dbba0da5e72ed22b2b8ba1084a0272c2c3df2baca7cb49ee0de4f9d6737dfcfa07ea69fcb4766a943a483d78f316dbe8d146"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 13:24:07.468653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 13:24:07.468997) ========= 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.taeBmiTfbc/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.3sphXo7fV5/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.005192 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 13:24:07.517365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 13:24:07.517678) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 13:24:07.518011) ========= ========= Total master_lag: 0.18 =========