builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0111 starttime: 1479353470.62 results: success (0) buildid: 20161116170825 builduid: 13a7df007d36486498e823bce2470bf0 revision: c27117f67fa3ff30bbd34bcd6c7536c0d10bd4ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 19:31:10.617669) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 19:31:10.618225) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 19:31:10.618552) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 19:31:10.644378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:31:10.644715) ========= 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.fcylvFtlDD/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.TCAdcGoR46/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 --2016-11-16 19:31:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.5M=0.001s 2016-11-16 19:31:10 (15.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125584 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:31:10.796076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:31:10.796539) ========= 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.fcylvFtlDD/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.TCAdcGoR46/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.026583 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:31:10.846462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:31:10.846872) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c27117f67fa3ff30bbd34bcd6c7536c0d10bd4ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c27117f67fa3ff30bbd34bcd6c7536c0d10bd4ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fcylvFtlDD/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.TCAdcGoR46/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 2016-11-16 19:31:10,945 truncating revision to first 12 chars 2016-11-16 19:31:10,945 Setting DEBUG logging. 2016-11-16 19:31:10,945 attempt 1/10 2016-11-16 19:31:10,945 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c27117f67fa3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-16 19:31:11,407 unpacking tar archive at: mozilla-central-c27117f67fa3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727950 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:31:11.601204) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 19:31:11.601566) ========= script_repo_revision: c27117f67fa3ff30bbd34bcd6c7536c0d10bd4ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 19:31:11.602055) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 19:31:11.602369) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 19:31:11.621172) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-11-16 19:31:11.621666) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fcylvFtlDD/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.TCAdcGoR46/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:31:11 INFO - MultiFileLogger online at 20161116 19:31:11 in /builds/slave/test 19:31:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:31:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:31:11 INFO - {'append_to_log': False, 19:31:11 INFO - 'base_work_dir': '/builds/slave/test', 19:31:11 INFO - 'blob_upload_branch': 'Firefox', 19:31:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:31:11 INFO - 'branch': 'Firefox', 19:31:11 INFO - 'buildbot_json_path': 'buildprops.json', 19:31:11 INFO - 'config_files': ('talos/mac_config.py',), 19:31:11 INFO - 'default_actions': ('clobber', 19:31:11 INFO - 'read-buildbot-config', 19:31:11 INFO - 'download-and-extract', 19:31:11 INFO - 'populate-webroot', 19:31:11 INFO - 'create-virtualenv', 19:31:11 INFO - 'install', 19:31:11 INFO - 'run-tests'), 19:31:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:31:11 INFO - 'download_minidump_stackwalk': True, 19:31:11 INFO - 'download_symbols': 'ondemand', 19:31:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:31:11 INFO - 'tooltool.py': '/tools/tooltool.py', 19:31:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:31:11 INFO - '/tools/misc-python/virtualenv.py')}, 19:31:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:31:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:31:11 INFO - 'installer_path': 'installer.exe', 19:31:11 INFO - 'log_level': 'info', 19:31:11 INFO - 'log_name': 'talos', 19:31:11 INFO - 'log_to_console': True, 19:31:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:31:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:31:11 INFO - 'opt_config_files': (), 19:31:11 INFO - 'pip_index': False, 19:31:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:31:11 INFO - 'cmd': ('bash', 19:31:11 INFO - '-c', 19:31:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:31:11 INFO - 'enabled': True, 19:31:11 INFO - 'halt_on_failure': False, 19:31:11 INFO - 'name': 'check_screen_resolution'},), 19:31:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:31:11 INFO - 'cmd': ('bash', 19:31:11 INFO - '-c', 19:31:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:31:11 INFO - 'enabled': True, 19:31:11 INFO - 'halt_on_failure': False, 19:31:11 INFO - 'name': 'check_screen_resolution'},), 19:31:11 INFO - 'run_cmd_checks_enabled': True, 19:31:11 INFO - 'sps_profile': False, 19:31:11 INFO - 'sps_profile_interval': 0, 19:31:11 INFO - 'suite': 'dromaeojs', 19:31:11 INFO - 'system_bits': '32', 19:31:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:31:11 INFO - 'title': 't-yosemite-r7-0111', 19:31:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:31:11 INFO - 'use_talos_json': True, 19:31:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:31:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:31:11 INFO - 'work_dir': 'build'} 19:31:11 INFO - [mozharness: 2016-11-17 03:31:11.834619Z] Running clobber step. 19:31:11 INFO - Running pre-action listener: _resource_record_pre_action 19:31:11 INFO - Running main action method: clobber 19:31:11 INFO - rmtree: /builds/slave/test/build 19:31:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:31:14 INFO - Running post-action listener: _resource_record_post_action 19:31:14 INFO - [mozharness: 2016-11-17 03:31:14.219233Z] Finished clobber step (success) 19:31:14 INFO - [mozharness: 2016-11-17 03:31:14.219365Z] Running read-buildbot-config step. 19:31:14 INFO - Running pre-action listener: _resource_record_pre_action 19:31:14 INFO - Running main action method: read_buildbot_config 19:31:14 INFO - Using buildbot properties: 19:31:14 INFO - { 19:31:14 INFO - "project": "", 19:31:14 INFO - "product": "firefox", 19:31:14 INFO - "script_repo_revision": "production", 19:31:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:31:14 INFO - "repository": "", 19:31:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:31:14 INFO - "buildid": "20161116170825", 19:31:14 INFO - "pgo_build": "False", 19:31:14 INFO - "basedir": "/builds/slave/test", 19:31:14 INFO - "buildnumber": 24, 19:31:14 INFO - "slavename": "t-yosemite-r7-0111", 19:31:14 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 19:31:14 INFO - "platform": "yosemite_r7", 19:31:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:31:14 INFO - "branch": "mozilla-central", 19:31:14 INFO - "repo_path": "mozilla-central", 19:31:14 INFO - "revision": "c27117f67fa3ff30bbd34bcd6c7536c0d10bd4ad", 19:31:14 INFO - "stage_platform": "macosx64", 19:31:14 INFO - "builduid": "13a7df007d36486498e823bce2470bf0", 19:31:14 INFO - "slavebuilddir": "test" 19:31:14 INFO - } 19:31:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 19:31:14 INFO - Running post-action listener: _resource_record_post_action 19:31:14 INFO - [mozharness: 2016-11-17 03:31:14.222789Z] Finished read-buildbot-config step (success) 19:31:14 INFO - [mozharness: 2016-11-17 03:31:14.222924Z] Running download-and-extract step. 19:31:14 INFO - Running pre-action listener: _resource_record_pre_action 19:31:14 INFO - Running main action method: download_and_extract 19:31:14 INFO - mkdir: /builds/slave/test/build/tests 19:31: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')]} 19:31:14 INFO - trying https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 19:31:14 INFO - Downloading https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:31:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 19:31:15 INFO - Downloaded 1199 bytes. 19:31:15 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:31:15 INFO - Using the following test package requirements: 19:31:15 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:31:15 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:31:15 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 19:31:15 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:31:15 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 19:31:15 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:31:15 INFO - u'jsshell-mac.zip'], 19:31:15 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:31:15 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 19:31:15 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:31:15 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:31:15 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 19:31:15 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:31:15 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 19:31:15 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:31:15 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 19:31:15 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:31:15 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 19:31:15 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:31:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:31:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:31:15 INFO - Fetch https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:31:16 INFO - Http code: 200 19:31:16 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 19:31:16 INFO - x-amz-cf-id: g5r0uAsLQ3o-kpj0h0sGxO01naa9c20UBFcQOFhxxtdNz-xl2ESvYw== 19:31:16 INFO - x-amz-version-id: ah8Y0LvdisdptRXUlc.iGHaKzri2qQZj 19:31:17 INFO - Expected file size: 16273470 19:31:17 INFO - Obtained file size: 16273470 19:31:24 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:31:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:31:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:31:24 INFO - Fetch https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:31:24 INFO - Http code: 200 19:31:24 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 19:31:24 INFO - x-amz-cf-id: yOLiwffP2HL8AgZODpXfobhqY4iV3kHG0eGdxT9kcDJmyxqxUj5cmw== 19:31:24 INFO - x-amz-version-id: ah8Y0LvdisdptRXUlc.iGHaKzri2qQZj 19:31:26 INFO - Expected file size: 16273470 19:31:26 INFO - Obtained file size: 16273470 19:31:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 19:31:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:31:32 INFO - Fetch https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 19:31:33 INFO - Http code: 200 19:31:33 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 19:31:33 INFO - x-amz-cf-id: 83ZU3p-Z9SXNhbkNNsVKDZQ_pDsGWjdoIMvJBHrw6UALjMyag3i0gw== 19:31:33 INFO - x-amz-version-id: Za_lvTsXkw7PKu6CKvKPpoJVLTEHxjvs 19:31:34 INFO - Expected file size: 14409389 19:31:34 INFO - Obtained file size: 14409389 19:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:35 INFO - trying https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:31:35 INFO - Downloading https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 19:31:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 19:31:39 INFO - Downloaded 110984111 bytes. 19:31:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:31:39 INFO - mkdir: /builds/slave/test/properties 19:31:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:31:39 INFO - Writing to file /builds/slave/test/properties/build_url 19:31:39 INFO - Contents: 19:31:39 INFO - build_url:https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:31:40 INFO - Running post-action listener: _resource_record_post_action 19:31:40 INFO - Running post-action listener: set_extra_try_arguments 19:31:40 INFO - [mozharness: 2016-11-17 03:31:40.395841Z] Finished download-and-extract step (success) 19:31:40 INFO - [mozharness: 2016-11-17 03:31:40.395951Z] Running populate-webroot step. 19:31:40 INFO - Running pre-action listener: _resource_record_pre_action 19:31:40 INFO - Running main action method: populate_webroot 19:31:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:31:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:31:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:31:40 INFO - '--tppagecycles', 19:31:40 INFO - '7'], 19:31:40 INFO - 'tests': ['tsvgm']}}, 19:31:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:31:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:31:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:31:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:31:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:31:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:31:40 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:31:40 INFO - 'talos_options': ['--disable-e10s'], 19:31:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:31:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:31:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:31:40 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:31:40 INFO - 'talos_options': ['--disable-e10s'], 19:31:40 INFO - 'tests': ['damp', 'tps']}, 19:31:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:31:40 INFO - 'tests': ['damp', 'tps']}, 19:31:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:31:40 INFO - 'tests': ['dromaeo_dom']}, 19:31:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:31:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:31:40 INFO - 'tests': ['basic_compositor_video']}, 19:31:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:31:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:31:40 INFO - 'tests': ['a11yr', 19:31:40 INFO - 'ts_paint', 19:31:40 INFO - 'tpaint', 19:31:40 INFO - 'sessionrestore', 19:31:40 INFO - 'sessionrestore_no_auto_restore', 19:31:40 INFO - 'tabpaint']}, 19:31:40 INFO - 'other-e10s': {'tests': ['a11yr', 19:31:40 INFO - 'ts_paint', 19:31:40 INFO - 'tpaint', 19:31:40 INFO - 'sessionrestore', 19:31:40 INFO - 'sessionrestore_no_auto_restore', 19:31:40 INFO - 'tabpaint']}, 19:31:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:31:40 INFO - 'ts_paint', 19:31:40 INFO - 'tpaint', 19:31:40 INFO - 'sessionrestore', 19:31:40 INFO - 'sessionrestore_no_auto_restore', 19:31:40 INFO - 'tabpaint']}, 19:31:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:31:40 INFO - 'ts_paint', 19:31:40 INFO - 'tpaint', 19:31:40 INFO - 'sessionrestore', 19:31:40 INFO - 'sessionrestore_no_auto_restore', 19:31:40 INFO - 'tabpaint']}, 19:31:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:31:40 INFO - 'tests': ['a11yr', 19:31:40 INFO - 'ts_paint', 19:31:40 INFO - 'tpaint', 19:31:40 INFO - 'sessionrestore', 19:31:40 INFO - 'sessionrestore_no_auto_restore', 19:31:40 INFO - 'tabpaint']}, 19:31:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:31:40 INFO - 'tests': ['a11yr', 19:31:40 INFO - 'ts_paint', 19:31:40 INFO - 'tpaint', 19:31:40 INFO - 'sessionrestore', 19:31:40 INFO - 'sessionrestore_no_auto_restore', 19:31:40 INFO - 'tabpaint']}, 19:31:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:31:40 INFO - 'tests': ['tsvgx', 19:31:40 INFO - 'tsvgr_opacity', 19:31:40 INFO - 'tart', 19:31:40 INFO - 'tscrollx', 19:31:40 INFO - 'cart']}, 19:31:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:31:40 INFO - 'tsvgr_opacity', 19:31:40 INFO - 'tart', 19:31:40 INFO - 'tscrollx', 19:31:40 INFO - 'cart']}, 19:31:40 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:31:40 INFO - 'talos_options': ['--disable-e10s'], 19:31:40 INFO - 'tests': ['tp5o']}, 19:31:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:31:40 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:31:40 INFO - 'talos_options': ['--disable-e10s', 19:31:40 INFO - '--xperf_path', 19:31:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:31:40 INFO - 'tests': ['tp5n']}, 19:31:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:31:40 INFO - 'talos_options': ['--xperf_path', 19:31:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:31:40 INFO - 'tests': ['tp5n']}}, 19:31:40 INFO - 'talos.zip': {'path': '', 19:31:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:31:40 INFO - Running post-action listener: _resource_record_post_action 19:31:40 INFO - [mozharness: 2016-11-17 03:31:40.414412Z] Finished populate-webroot step (success) 19:31:40 INFO - [mozharness: 2016-11-17 03:31:40.414540Z] Running create-virtualenv step. 19:31:40 INFO - Running pre-action listener: _resource_record_pre_action 19:31:40 INFO - Running main action method: create_virtualenv 19:31:40 INFO - Creating virtualenv /builds/slave/test/build/venv 19:31:40 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 19:31:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:31:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:31:40 INFO - Using real prefix '/tools/python27' 19:31:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:31:41 INFO - Installing distribute.............................................................................................................................................................................................done. 19:31:44 INFO - Installing pip.................done. 19:31:44 INFO - Return code: 0 19:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:31:44 INFO - Reading from file tmpfile_stdout 19:31:44 INFO - Output received: 19:31:44 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) 19:31:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:44 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 0x106bfd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b73570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa809ce9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a13d30>, '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 0x10687adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a0bb20>, '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.fcylvFtlDD/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.TCAdcGoR46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:31:44 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 19:31:44 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 19:31:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcylvFtlDD/Render', 19:31:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:31:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:31:44 INFO - 'HOME': '/Users/cltbld', 19:31:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:31:44 INFO - 'LOGNAME': 'cltbld', 19:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:44 INFO - 'MOZ_NO_REMOTE': '1', 19:31:44 INFO - 'NO_EM_RESTART': '1', 19:31:44 INFO - 'PAGER': '/bin/cat', 19:31:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:44 INFO - 'PWD': '/builds/slave/test', 19:31:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:31:44 INFO - 'SHELL': '/bin/bash', 19:31:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TCAdcGoR46/Listeners', 19:31:44 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:31:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:31:44 INFO - 'USER': 'cltbld', 19:31:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:31:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:44 INFO - 'XPC_FLAGS': '0x0', 19:31:44 INFO - 'XPC_SERVICE_NAME': '0', 19:31:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:44 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 19:31:44 INFO - Cleaning up... 19:31:44 INFO - Return code: 0 19:31:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:44 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 0x106bfd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b73570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa809ce9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a13d30>, '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 0x10687adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a0bb20>, '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.fcylvFtlDD/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.TCAdcGoR46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:31:44 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 19:31:44 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 19:31:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcylvFtlDD/Render', 19:31:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:31:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:31:44 INFO - 'HOME': '/Users/cltbld', 19:31:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:31:44 INFO - 'LOGNAME': 'cltbld', 19:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:44 INFO - 'MOZ_NO_REMOTE': '1', 19:31:44 INFO - 'NO_EM_RESTART': '1', 19:31:44 INFO - 'PAGER': '/bin/cat', 19:31:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:44 INFO - 'PWD': '/builds/slave/test', 19:31:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:31:44 INFO - 'SHELL': '/bin/bash', 19:31:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TCAdcGoR46/Listeners', 19:31:44 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:31:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:31:44 INFO - 'USER': 'cltbld', 19:31:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:31:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:44 INFO - 'XPC_FLAGS': '0x0', 19:31:44 INFO - 'XPC_SERVICE_NAME': '0', 19:31:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:44 INFO - Downloading/unpacking psutil>=3.1.1 19:31:44 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 19:31:44 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 19:31:44 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 19:31:44 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 19:31:44 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 19:31:44 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 19:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:31:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:31:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:31:48 INFO - Installing collected packages: psutil 19:31:48 INFO - Running setup.py install for psutil 19:31:48 INFO - building 'psutil._psutil_osx' extension 19:31:48 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 19:31:48 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 19:31:49 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 19:31:49 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 19:31:49 INFO - building 'psutil._psutil_posix' extension 19:31:49 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 19:31:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:31:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:31:49 INFO - ^ 19:31:49 INFO - 1 warning generated. 19:31:49 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 19:31:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:31:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:31:49 INFO - Successfully installed psutil 19:31:49 INFO - Cleaning up... 19:31:49 INFO - Return code: 0 19:31:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bfd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b73570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa809ce9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a13d30>, '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 0x10687adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a0bb20>, '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.fcylvFtlDD/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.TCAdcGoR46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:31:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:31:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcylvFtlDD/Render', 19:31:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:31:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:31:49 INFO - 'HOME': '/Users/cltbld', 19:31:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:31:49 INFO - 'LOGNAME': 'cltbld', 19:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:49 INFO - 'MOZ_NO_REMOTE': '1', 19:31:49 INFO - 'NO_EM_RESTART': '1', 19:31:49 INFO - 'PAGER': '/bin/cat', 19:31:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:49 INFO - 'PWD': '/builds/slave/test', 19:31:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:31:49 INFO - 'SHELL': '/bin/bash', 19:31:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TCAdcGoR46/Listeners', 19:31:49 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:31:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:31:49 INFO - 'USER': 'cltbld', 19:31:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:31:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:49 INFO - 'XPC_FLAGS': '0x0', 19:31:49 INFO - 'XPC_SERVICE_NAME': '0', 19:31:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:31:49 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 19:31:49 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 19:31:49 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 19:31:49 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 19:31:49 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 19:31:49 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 19:31:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:31:52 INFO - Installing collected packages: mozsystemmonitor 19:31:52 INFO - Running setup.py install for mozsystemmonitor 19:31:52 INFO - Successfully installed mozsystemmonitor 19:31:52 INFO - Cleaning up... 19:31:52 INFO - Return code: 0 19:31:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:52 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 0x106bfd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b73570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa809ce9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a13d30>, '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 0x10687adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a0bb20>, '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.fcylvFtlDD/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.TCAdcGoR46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:31:52 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 19:31:52 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 19:31:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcylvFtlDD/Render', 19:31:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:31:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:31:52 INFO - 'HOME': '/Users/cltbld', 19:31:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:31:52 INFO - 'LOGNAME': 'cltbld', 19:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:52 INFO - 'MOZ_NO_REMOTE': '1', 19:31:52 INFO - 'NO_EM_RESTART': '1', 19:31:52 INFO - 'PAGER': '/bin/cat', 19:31:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:52 INFO - 'PWD': '/builds/slave/test', 19:31:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:31:52 INFO - 'SHELL': '/bin/bash', 19:31:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TCAdcGoR46/Listeners', 19:31:52 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:31:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:31:52 INFO - 'USER': 'cltbld', 19:31:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:31:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:52 INFO - 'XPC_FLAGS': '0x0', 19:31:52 INFO - 'XPC_SERVICE_NAME': '0', 19:31:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:52 INFO - Downloading/unpacking jsonschema==2.5.1 19:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:31:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:31:55 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 19:31:55 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 19:31:55 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 19:31:55 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 19:31:55 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 19:31:55 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 19:31:55 INFO - Downloading functools32-3.2.3-2.tar.gz 19:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:31:55 INFO - warning: no files found matching '*.txt' 19:31:55 INFO - no previously-included directories found matching 'build' 19:31:55 INFO - no previously-included directories found matching 'dist' 19:31:55 INFO - no previously-included directories found matching '.git*' 19:31:55 INFO - Installing collected packages: jsonschema, functools32 19:31:55 INFO - Running setup.py install for functools32 19:31:55 INFO - warning: no files found matching '*.txt' 19:31:55 INFO - no previously-included directories found matching 'build' 19:31:55 INFO - no previously-included directories found matching 'dist' 19:31:55 INFO - no previously-included directories found matching '.git*' 19:31:55 INFO - Successfully installed jsonschema functools32 19:31:55 INFO - Cleaning up... 19:31:56 INFO - Return code: 0 19:31:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:31:56 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')]} 19:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:56 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')]} 19:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:56 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 0x106bfd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b73570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa809ce9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a13d30>, '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 0x10687adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a0bb20>, '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.fcylvFtlDD/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.TCAdcGoR46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:31:56 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 19:31:56 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 19:31:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcylvFtlDD/Render', 19:31:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:31:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:31:56 INFO - 'HOME': '/Users/cltbld', 19:31:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:31:56 INFO - 'LOGNAME': 'cltbld', 19:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:56 INFO - 'MOZ_NO_REMOTE': '1', 19:31:56 INFO - 'NO_EM_RESTART': '1', 19:31:56 INFO - 'PAGER': '/bin/cat', 19:31:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:56 INFO - 'PWD': '/builds/slave/test', 19:31:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:31:56 INFO - 'SHELL': '/bin/bash', 19:31:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TCAdcGoR46/Listeners', 19:31:56 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:31:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:31:56 INFO - 'USER': 'cltbld', 19:31:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:31:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:56 INFO - 'XPC_FLAGS': '0x0', 19:31:56 INFO - 'XPC_SERVICE_NAME': '0', 19:31:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:31:56 INFO - Cleaning up... 19:31:56 INFO - Return code: 0 19:31:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:31:56 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')]} 19:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:56 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')]} 19:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:56 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 0x106bfd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b73570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa809ce9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a13d30>, '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 0x10687adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a0bb20>, '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.fcylvFtlDD/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.TCAdcGoR46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:31:56 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 19:31:56 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 19:31:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcylvFtlDD/Render', 19:31:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:31:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:31:56 INFO - 'HOME': '/Users/cltbld', 19:31:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:31:56 INFO - 'LOGNAME': 'cltbld', 19:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:56 INFO - 'MOZ_NO_REMOTE': '1', 19:31:56 INFO - 'NO_EM_RESTART': '1', 19:31:56 INFO - 'PAGER': '/bin/cat', 19:31:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:56 INFO - 'PWD': '/builds/slave/test', 19:31:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:31:56 INFO - 'SHELL': '/bin/bash', 19:31:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TCAdcGoR46/Listeners', 19:31:56 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:31:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:31:56 INFO - 'USER': 'cltbld', 19:31:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:31:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:56 INFO - 'XPC_FLAGS': '0x0', 19:31:56 INFO - 'XPC_SERVICE_NAME': '0', 19:31:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:56 INFO - Downloading/unpacking blobuploader==1.2.4 19:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:59 INFO - Downloading blobuploader-1.2.4.tar.gz 19:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:31:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:31:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:00 INFO - Downloading docopt-0.6.1.tar.gz 19:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:32:00 INFO - Installing collected packages: blobuploader, requests, docopt 19:32:00 INFO - Running setup.py install for blobuploader 19:32:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:32:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:32:00 INFO - Running setup.py install for requests 19:32:01 INFO - Running setup.py install for docopt 19:32:01 INFO - Successfully installed blobuploader requests docopt 19:32:01 INFO - Cleaning up... 19:32:01 INFO - Return code: 0 19:32:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32:01 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')]} 19:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:01 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')]} 19:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:01 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 0x106bfd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b73570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa809ce9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a13d30>, '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 0x10687adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a0bb20>, '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.fcylvFtlDD/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.TCAdcGoR46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:32:01 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 19:32:01 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 19:32:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcylvFtlDD/Render', 19:32:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:32:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:32:01 INFO - 'HOME': '/Users/cltbld', 19:32:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:32:01 INFO - 'LOGNAME': 'cltbld', 19:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:01 INFO - 'MOZ_NO_REMOTE': '1', 19:32:01 INFO - 'NO_EM_RESTART': '1', 19:32:01 INFO - 'PAGER': '/bin/cat', 19:32:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:01 INFO - 'PWD': '/builds/slave/test', 19:32:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:32:01 INFO - 'SHELL': '/bin/bash', 19:32:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TCAdcGoR46/Listeners', 19:32:01 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:32:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:32:01 INFO - 'USER': 'cltbld', 19:32:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:32:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:01 INFO - 'XPC_FLAGS': '0x0', 19:32:01 INFO - 'XPC_SERVICE_NAME': '0', 19:32:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:32:01 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-_7SLGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:32:01 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-qZ7FWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:32:01 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-HzQKrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:32:01 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-X56jur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:32:01 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-pRgdOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:32:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-H36mmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:32:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-DJdspy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:32:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-0PtWPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:32:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-pSCa0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:32:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Q3bVXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:32:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-MTsv92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:32:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-HJa5Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:32:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-ZYBucs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:32:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-41p91v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-4OzXn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:32:03 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-YrgUbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:32:03 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-n9IRMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:32:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:32:03 INFO - Running setup.py install for manifestparser 19:32:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:32:03 INFO - Running setup.py install for mozcrash 19:32:03 INFO - Running setup.py install for mozdebug 19:32:03 INFO - Running setup.py install for mozdevice 19:32:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:32:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:32:03 INFO - Running setup.py install for mozfile 19:32:04 INFO - Running setup.py install for mozhttpd 19:32:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:32:04 INFO - Running setup.py install for mozinfo 19:32:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:32:04 INFO - Running setup.py install for mozInstall 19:32:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:32:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:32:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:32:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:32:04 INFO - Running setup.py install for mozleak 19:32:04 INFO - Running setup.py install for mozlog 19:32:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:32:04 INFO - Running setup.py install for moznetwork 19:32:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:32:04 INFO - Running setup.py install for mozprocess 19:32:05 INFO - Running setup.py install for mozprofile 19:32:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:32:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:32:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:32:05 INFO - Running setup.py install for mozrunner 19:32:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:32:05 INFO - Running setup.py install for mozscreenshot 19:32:05 INFO - Running setup.py install for moztest 19:32:05 INFO - Running setup.py install for mozversion 19:32:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:32:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:32:05 INFO - Cleaning up... 19:32:05 INFO - Return code: 0 19:32:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32:05 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')]} 19:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:06 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')]} 19:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:06 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 0x106bfd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b73570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa809ce9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a13d30>, '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 0x10687adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a0bb20>, '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.fcylvFtlDD/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.TCAdcGoR46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:32:06 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 19:32:06 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 19:32:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcylvFtlDD/Render', 19:32:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:32:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:32:06 INFO - 'HOME': '/Users/cltbld', 19:32:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:32:06 INFO - 'LOGNAME': 'cltbld', 19:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:06 INFO - 'MOZ_NO_REMOTE': '1', 19:32:06 INFO - 'NO_EM_RESTART': '1', 19:32:06 INFO - 'PAGER': '/bin/cat', 19:32:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:06 INFO - 'PWD': '/builds/slave/test', 19:32:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:32:06 INFO - 'SHELL': '/bin/bash', 19:32:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TCAdcGoR46/Listeners', 19:32:06 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:32:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:32:06 INFO - 'USER': 'cltbld', 19:32:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:32:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:06 INFO - 'XPC_FLAGS': '0x0', 19:32:06 INFO - 'XPC_SERVICE_NAME': '0', 19:32:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:32:06 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-w6AJds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:32:07 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)) 19:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:32:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-FUCXNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:32:07 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)) 19:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:32:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-vjZ2V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:32:07 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)) 19:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:32:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-s0KG0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:32:07 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)) 19:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:32:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-rh7nFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:32:07 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)) 19:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:32:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-dYfD_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:32:07 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)) 19:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:32:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-K5hzu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:32:07 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)) 19:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:32:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-lQX1uY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:32:07 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)) 19:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:32:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-mv9t3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:32:07 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)) 19:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:32:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-MQVtd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:32:08 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)) 19:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:32:08 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-AMSUsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:32:08 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)) 19:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:32:08 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-2kZ4Qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:32:08 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)) 19:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:32:08 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-7ShYn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:32:08 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)) 19:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:32:08 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-RjQwQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:32:08 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)) 19:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:08 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-GllAZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:08 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)) 19:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:32:08 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-FpF10c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 19:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:32:08 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-M8pknw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:32:08 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)) 19:32:08 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)) 19:32:08 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)) 19:32:08 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)) 19:32:08 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)) 19:32:08 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)) 19:32:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:32:08 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 19:32:08 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 19:32:08 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 19:32:08 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 19:32:08 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 19:32:08 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 19:32:11 INFO - Downloading blessings-1.6.tar.gz 19:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:32:11 INFO - Installing collected packages: blessings 19:32:11 INFO - Running setup.py install for blessings 19:32:11 INFO - Successfully installed blessings 19:32:11 INFO - Cleaning up... 19:32:12 INFO - Return code: 0 19:32:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:32:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:32:12 INFO - Reading from file tmpfile_stdout 19:32:12 INFO - Current package versions: 19:32:12 INFO - blessings == 1.6 19:32:12 INFO - blobuploader == 1.2.4 19:32:12 INFO - docopt == 0.6.1 19:32:12 INFO - functools32 == 3.2.3-2 19:32:12 INFO - jsonschema == 2.5.1 19:32:12 INFO - manifestparser == 1.1 19:32:12 INFO - mozInstall == 1.12 19:32:12 INFO - mozcrash == 1.0 19:32:12 INFO - mozdebug == 0.1 19:32:12 INFO - mozdevice == 0.48 19:32:12 INFO - mozfile == 1.2 19:32:12 INFO - mozhttpd == 0.7 19:32:12 INFO - mozinfo == 0.9 19:32:12 INFO - mozleak == 0.1 19:32:12 INFO - mozlog == 3.4 19:32:12 INFO - moznetwork == 0.27 19:32:12 INFO - mozprocess == 0.23 19:32:12 INFO - mozprofile == 0.28 19:32:12 INFO - mozrunner == 6.13 19:32:12 INFO - mozscreenshot == 0.1 19:32:12 INFO - mozsystemmonitor == 0.3 19:32:12 INFO - moztest == 0.7 19:32:12 INFO - mozversion == 1.4 19:32:12 INFO - psutil == 3.1.1 19:32:12 INFO - requests == 1.2.3 19:32:12 INFO - wsgiref == 0.1.2 19:32:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:12 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 0x106bfd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b73570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa809ce9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a13d30>, '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 0x10687adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a0bb20>, '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.fcylvFtlDD/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.TCAdcGoR46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:32:12 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 19:32:12 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 19:32:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcylvFtlDD/Render', 19:32:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:32:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:32:12 INFO - 'HOME': '/Users/cltbld', 19:32:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:32:12 INFO - 'LOGNAME': 'cltbld', 19:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:12 INFO - 'MOZ_NO_REMOTE': '1', 19:32:12 INFO - 'NO_EM_RESTART': '1', 19:32:12 INFO - 'PAGER': '/bin/cat', 19:32:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:12 INFO - 'PWD': '/builds/slave/test', 19:32:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:32:12 INFO - 'SHELL': '/bin/bash', 19:32:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TCAdcGoR46/Listeners', 19:32:12 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:32:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:32:12 INFO - 'USER': 'cltbld', 19:32:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:32:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:12 INFO - 'XPC_FLAGS': '0x0', 19:32:12 INFO - 'XPC_SERVICE_NAME': '0', 19:32:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:12 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)) 19:32:12 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)) 19:32:12 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)) 19:32:12 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)) 19:32:12 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)) 19:32:12 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)) 19:32:12 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)) 19:32:12 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)) 19:32:12 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)) 19:32:12 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)) 19:32:12 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)) 19:32:12 INFO - Cleaning up... 19:32:12 INFO - Return code: 0 19:32:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bfd3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b73570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa809ce9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a13d30>, '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 0x10687adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a0bb20>, '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.fcylvFtlDD/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.TCAdcGoR46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 19:32:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:32:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcylvFtlDD/Render', 19:32:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:32:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:32:12 INFO - 'HOME': '/Users/cltbld', 19:32:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:32:12 INFO - 'LOGNAME': 'cltbld', 19:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:12 INFO - 'MOZ_NO_REMOTE': '1', 19:32:12 INFO - 'NO_EM_RESTART': '1', 19:32:12 INFO - 'PAGER': '/bin/cat', 19:32:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:12 INFO - 'PWD': '/builds/slave/test', 19:32:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:32:12 INFO - 'SHELL': '/bin/bash', 19:32:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TCAdcGoR46/Listeners', 19:32:12 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:32:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:32:12 INFO - 'USER': 'cltbld', 19:32:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:32:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:12 INFO - 'XPC_FLAGS': '0x0', 19:32:12 INFO - 'XPC_SERVICE_NAME': '0', 19:32:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:32:12 INFO - Cleaning up... 19:32:12 INFO - Return code: 0 19:32:12 INFO - Running post-action listener: _resource_record_post_action 19:32:12 INFO - Running post-action listener: _start_resource_monitoring 19:32:12 INFO - Starting resource monitoring. 19:32:12 INFO - [mozharness: 2016-11-17 03:32:12.862559Z] Finished create-virtualenv step (success) 19:32:12 INFO - [mozharness: 2016-11-17 03:32:12.863571Z] Running install step. 19:32:12 INFO - Running pre-action listener: _resource_record_pre_action 19:32:12 INFO - Running main action method: install 19:32:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:32:13 INFO - Reading from file tmpfile_stdout 19:32:13 INFO - Detecting whether we're running mozinstall >=1.0... 19:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:32:13 INFO - Reading from file tmpfile_stdout 19:32:13 INFO - Output received: 19:32:13 INFO - Usage: mozinstall [options] installer 19:32:13 INFO - Options: 19:32:13 INFO - -h, --help show this help message and exit 19:32:13 INFO - -d DEST, --destination=DEST 19:32:13 INFO - Directory to install application into. [default: 19:32:13 INFO - "/builds/slave/test"] 19:32:13 INFO - --app=APP Application being installed. [default: firefox] 19:32:13 INFO - mkdir: /builds/slave/test/build/application 19:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:32:47 INFO - Reading from file tmpfile_stdout 19:32:47 INFO - Output received: 19:32:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:32:47 INFO - Running post-action listener: _resource_record_post_action 19:32:47 INFO - [mozharness: 2016-11-17 03:32:47.021662Z] Finished install step (success) 19:32:47 INFO - [mozharness: 2016-11-17 03:32:47.021791Z] Running run-tests step. 19:32:47 INFO - Running pre-action listener: _resource_record_pre_action 19:32:47 INFO - Running main action method: run_tests 19:32:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:32:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:32:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:32:47 INFO - 2016-11-16 19:32:47.036 screenresolution[1624:7417] starting screenresolution argv=screenresolution get 19:32:47 INFO - 2016-11-16 19:32:47.038 screenresolution[1624:7417] Display 0: 1600x1200x32@60 19:32:47 INFO - 2016-11-16 19:32:47.044 screenresolution[1625:7419] starting screenresolution argv=screenresolution list 19:32:47 INFO - Available Modes on Display 0 19:32:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:32:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:32:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:32:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:32:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:32:47 INFO - Intel Iris: 19:32:47 INFO - Chipset Model: Intel Iris 19:32:47 INFO - Type: GPU 19:32:47 INFO - Bus: Built-In 19:32:47 INFO - VRAM (Dynamic, Max): 1536 MB 19:32:47 INFO - Vendor: Intel (0x8086) 19:32:47 INFO - Device ID: 0x0a2e 19:32:47 INFO - Revision ID: 0x0009 19:32:47 INFO - Displays: 19:32:47 INFO - Display: 19:32:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:32:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:32:47 INFO - Display Serial Number: 1600x1200 60 19:32:47 INFO - Main Display: Yes 19:32:47 INFO - Mirror: Off 19:32:47 INFO - Online: Yes 19:32:47 INFO - Rotation: Supported 19:32:47 INFO - Return code: 0 19:32:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:32:47 INFO - Python 2.7.3 19:32:47 INFO - Return code: 0 19:32:47 INFO - grabbing minidump binary from tooltool 19:32:47 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')]} 19:32:47 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 0x106a13d30>, '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 0x10687adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a0bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:32:47 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 19:32:47 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 19:32:47 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 19:32:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:32:47 INFO - Return code: 0 19:32:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:32:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:32:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:32:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:32:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:32:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 19:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0111 --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 19:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcylvFtlDD/Render', 19:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:32:47 INFO - 'HOME': '/Users/cltbld', 19:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:32:47 INFO - 'LOGNAME': 'cltbld', 19:32:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:32:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:47 INFO - 'MOZ_NO_REMOTE': '1', 19:32:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:32:47 INFO - 'NO_EM_RESTART': '1', 19:32:47 INFO - 'PAGER': '/bin/cat', 19:32:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:47 INFO - 'PWD': '/builds/slave/test', 19:32:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:32:47 INFO - 'SHELL': '/bin/bash', 19:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TCAdcGoR46/Listeners', 19:32:47 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 19:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:32:47 INFO - 'USER': 'cltbld', 19:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:47 INFO - 'XPC_FLAGS': '0x0', 19:32:47 INFO - 'XPC_SERVICE_NAME': '0', 19:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:32:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 19:32:47 INFO - mozversion application_buildid: 20161116170825 19:32:47 INFO - mozversion application_changeset: c27117f67fa3ff30bbd34bcd6c7536c0d10bd4ad 19:32:47 INFO - mozversion application_display_name: Nightly 19:32:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:32:47 INFO - mozversion application_name: Firefox 19:32:47 INFO - mozversion application_remotingname: firefox 19:32:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:32:47 INFO - mozversion application_vendor: Mozilla 19:32:47 INFO - mozversion application_version: 53.0a1 19:32:47 INFO - mozversion platform_buildid: 20161116170825 19:32:47 INFO - mozversion platform_changeset: c27117f67fa3ff30bbd34bcd6c7536c0d10bd4ad 19:32:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:32:47 INFO - mozversion platform_version: 53.0a1 19:32:47 INFO - using testdate: 1479353567 19:32:47 INFO - actual date: 1479353567 19:32:47 INFO - starting webserver on 'localhost:49242' 19:32:47 INFO - SUITE-START | Running 2 tests 19:32:47 INFO - TEST-START | dromaeo_css 19:32:47 INFO - operating with platform_type : mac_ 19:32:47 INFO - Initialising browser for dromaeo_css test... 19:32:47 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpAPkHzz/profile http://localhost:49242/getInfo.html) 19:32:50 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 19:32:50 INFO - PROCESS | 1635 | colorDepth:24 19:32:50 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 19:32:50 INFO - PROCESS | 1635 | __metrics 19:32:50 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:32:50 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:32:50 INFO - TEST-INFO | 1635: exit 0 19:32:50 INFO - Browser initialized. 19:32:50 INFO - Running cycle 1/1 for dromaeo_css test... 19:32:50 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpAPkHzz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:33:02 INFO - PROCESS | 1637 | RSS: Main: 237846528 19:33:02 INFO - PROCESS | 1637 | 19:33:54 INFO - PROCESS | 1637 | 1479353634431 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:36:06 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 19:36:08 INFO - PROCESS | 1637 | RSS: Main: 388718592 19:36:08 INFO - PROCESS | 1637 | 19:39:11 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 19:39:11 INFO - PROCESS | 1637 | RSS: Main: 371007488 19:39:11 INFO - PROCESS | 1637 | 19:42:14 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 19:42:15 INFO - PROCESS | 1637 | RSS: Main: 335171584 19:42:15 INFO - PROCESS | 1637 | 19:45:17 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 19:45:17 INFO - PROCESS | 1637 | RSS: Main: 349704192 19:45:17 INFO - PROCESS | 1637 | 19:48:21 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 19:48:22 INFO - PROCESS | 1637 | RSS: Main: 333889536 19:48:22 INFO - PROCESS | 1637 | 19:51:25 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 19:51:25 INFO - PROCESS | 1637 | RSS: Main: 402436096 19:51:25 INFO - PROCESS | 1637 | 19:51:25 INFO - PROCESS | 1637 | __start_tp_report 19:51:25 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 19:51:25 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 19:51:25 INFO - PROCESS | 1637 | |i|pagename|runs| 19:51:25 INFO - PROCESS | 1637 | |0;dojo.html;2718.456308738252;3351.8826841060554;3362.17626681463;3388.440907250304;3417.6240613532523;5607.691576963265;5707.6290041147295;5729.111987641917;5794.420557944209;5809.244798176236;5707.71461426928;5753.510951569111;5796.855078623036;5799.304083509975;5852.151438041481;5170.276161337416;5205.973970130144;5222.843314700546;5287.995280896636;5315.840524784263;5375.247465354853;5381.81163659272;5387.595930305223;5406.513413792758;5417.485338892819;4450.777461126947;5162.974185129088;5325.201219817059;5351.197320401932;5433.212184233304;5152.458991805844;5171.637985341028;5208.166693329087;5280.947190528084;5288.206768984644;5166.457521960216;5178.974105129488;5184.766685499161;5222.791088356461;5226.686398816045;5612.438756124396;5625.212470254168;5648.774049038034;5659.207710920475;5691.345495268056;6082.813851298998;6144.279601711528;6161.815145545596;6176.536759742992;6177.073438984144;6165.198524191826;6196.349383314732;6231.937680623181;6234.064890266451;6317.715702793385;5792.333881603669;5859.765609375662;5865.648061116347;5868.911966320508;5890.469857712784;6245.219347581552;6299.937000629935;6321.620702757849;6329.4303512683155;6333.334999825044;6120.204373431426;6154.076888466766;6158.076288556663;6160.876782464416;6171.938280617226;6202.1937148171355;6233.844153896189;6238;6270.655113968684;6289.056641503719;6218.689065546704;6262.185915830913;6271.560990730696;6278.6860656966965;6286.182796236551;6204.13142160098;6262.091996660459;6266.811995640138;6271.717772700239;6295.842603934938;4861.173600487926;4904.2643603459765;4913.606911447076;4952.62855285855;5002.974985125124;4381.84663536781;4470.552944705503;4474.574915383034;4503.301988191835;4512.458504979423;5772.509336706427;5823.650580965155;5877.9118313225335;5880.323762767251;5927.9407205928255;6221.666874921904;6230.968845155745;6236.563440559208;6241.875162496724;6250.468710159687;5866.50134738552;5886.852828679317;5889.882202355929;5899.557533185029;5908.20239267702;5332.413434522199;5377.274068000848;5382.811601593926;5383.300170977826;5432.619716619799;6370.299267080617;6407.327230640809;6408.935910640834;6428.4857211423905;6432.549721519449;6155.907661384993;6245.594036387621;6246.906296405648;6248.812535623939;6261.78083767066;6195.96902015487;6243.687815609111;6277.591956522811;6407.871842563216;6415.3263907289065;6136.110264011604;6171.660558669317;6190.938090619036;6213.347598502092;6220.253569571681;4837.903241935212;6195.132681424694;6209.875802484015;6218.253809542884;6253.09330147117;6025.246844144482;6099.024156134997;6126.632402055712;6161.876762464636;6182.227221597301;6097.359777223328;6101.145839582551;6108.480779133645;6153.84615384619;6169.96915015422;6019.458248757633;6042.214512113573;6044.455998960115;6047.123167140828;6065;5994.310654274815;6134.693265336805;6136.693165341804;6155.507559395327;6156.969215154075;5942.019566771607;6010.759569617341;6021.638701677914;6025.939740602538;6111.113888486234 19:51:25 INFO - PROCESS | 1637 | |1;ext.html;482.76585855859923;510.1404134034152;520.6927912531605;523.6674711558162;531.4924247343787;25209.873950630245;32092.03723888284;33178.8341058295;33205;33246.33507329852;32944.17639559012;33404.33191336178;33487.49768753465;33530;33636.82271120511;7226.096737907775;7407.222241664628;7408.666610002563;7412.888806667905;7429.331360177583;7615;7708.30625243728;7710.961445192795;7730.458867879251;7731.961340193291;7676.385889128885;7742.690292388326;7744.457887947846;7748.728794492194;7763.844723105534;7664.846703065935;7717.652705628204;7730.458867879251;7738.845223095506;7750.883736743954;7643.923560764432;7716.459847810655;7728.111267204287;7730.497517661334;7739.032620922385;30801;31169.688303116905;31192;31225.53161702576;31293.687063129306;3269.6893795089427;3324.6010478742705;3325.5006383729065;3712.201876596545;3790.33669107905;20961;21221.78778212229;21462.785372146234;22046.559068818693;22116.778832211632;2789.17719272815;2846.117703511918;2851.5152424087955;2851.743343099131;2861.1130549529503;455751;456033;456760;459834;461298.6935065337;59988.40011599828;60342.79314413687;60397.396026040056;60419.39580604226;60456.69771651202;34030.319393611986;34926.476102858476;58611.82776344449;58637.12044319339;59053;15538.844611553739;16076.678466430605;16098.195090245441;16132.193390330436;16221.59446013859;12288.324142172087;12311.753764924651;12351;12359.3820308986;12392.876071239352;18962.24151033943;19017.80982190188;19045.90477047606;19057.714134287995;19064.33274835374;6365.872682546323;6661.667666466629;6849.554778939353;7286.781396558112;7726.652300646484;738.1499682942303;825.0553116681366;955.460165006769;986.3292960786733;1100.6918062942389;27095.32261693434;27616.309592259953;28803.855980719964;29116.57527330517;29488.705112949025;1047;1062.2829590026702;1073.3184427888348;1084.1543595994979;1116.7264020315074;14604.853951460349;14646.84832370407;14983.250837458083;15203.209246442773;15226.162561059247;477629;650707;650886;652041;654124;51808.740956294976;52289.738551307;52297;52347.47652523502;52575.47424525706;1229.9077569182348;1267.087696858279;1322.6494978830426;1334.9532766353132;1365.4128724648497;27992.58011129794;28889.277768055967;28974.855125724236;29692.55461168041;29873.70126298709;49169;49617.751911241656;49856.501434985184;49863;49874.750626246634;503599;510054;510179;512459;513222.4338878282;21643.637090527598;21797.019134138685;24682.382940426633;24711.87644061768;24937.501249975263;41172.176556469305;41451.37822932598;41605;41909;42292.577074228866;34104.829475852464;34122.658773411946;34439;34938.82530587432;35180;33606;34050.65949340574;34094.48858267078;34817.12957176091;34942.82528587442;33329.83335083309;33370.99887003394;33491.162720932174;33501.99494015183;35370.46944295786;23254.069837207;29943.85028074846;30796;31208;31361.372772544877;17974.2810287587;22083.227087051877;22572;23017.424564386023;23068.077276908734 19:51:25 INFO - PROCESS | 1637 | |2;jquery.html;352.3094734320731;369.67653303359555;373.48086160237256;382.38245233947174;403.2841705971899;12053.276803391791;12353.629391118258;12884.871151288497;15792.526224213263;16175.595610109753;18905.527361815963;19085.809141908576;19177.27404533592;19749.40751777449;19933.003349832525;4883.316335712994;5261.158214685651;5271.736413179345;5272.683638981654;5287.550558202557;4344.522102568731;4455.598996090352;4775.474697783241;4873.975630121844;4893.779779909913;4806.134895718769;4812.278158276252;4818.0005297801545;4818.204996175645;4822.6624136310475;4599.44806623204;4755.857324280277;4820.156472617296;4825.203841366153;4825.469198388209;4639.8144074237325;4672.2057250267535;4678.672492925497;4683.250679891235;4684.601808846252;12030.27818330903;12280.692982675415;15015.07206094812;20784.064717087767;21021.5795684087;2174.510735084609;2290.1068583252545;2291.3584196425027;2313.8611683299055;2374.0112432217234;8379.95810020946;8801.867971980426;9186.356955013152;9278.536073196314;9421.952890235574;1361.748076605821;1680.7562903378941;1731.5151757507917;1740.295180451919;1749.6063385738235;89111.55444222737;109583;113549;113660.99999999917;116399;8941.910580894108;11291.943540282246;11391.772164556829;11413.65759027214;11611.6516504505;12870.871291287154;14218.217998010208;14249.572512824425;14250.857491424953;14263.286835658384;6239.251289845248;7255.347018768336;8003.839923201504;8082.434229603871;8472.025717042496;8077.798055048554;8115.1073381927945;8154.103048664642;8264.752057438287;8302.294304984023;3691.7415780895617;4352.804123814436;4480.731156130642;4555.385023021916;4590;1842.8525717942532;1896.933607323737;1898.5443493561445;1900.8194221548931;1906.7606056063669;864.943778654398;866.3978534918298;900.4147304252158;927.4296307770672;939.8872135343803;16589.50231493033;19655.312064077687;19662.311819086262;20667.4833129173;20835.583288334452;854.9016863060828;911.1207684584408;952.880365570452;962.259060523393;1015.619142821442;8812.295016398673;10211.948940255252;10747.892521074846;10824.350538967687;10855.51150198243;541434;545159;553468;558490;565839;65464.345356545826;90776.23107621523;96391;129144;131046;927.5501381829807;940.8635747816528;965.9275554333312;1015.0914931136591;1016.8474728790593;17622.82377176212;17781.110944452983;18037.72943405876;18113.45659630213;18482;55370.72314638562;55669.44330556643;56440.717796410754;56584.43415565956;57294.713526432104;73316.63341683257;78913;79417.60291198739;80561.59719201367;80630.19369806227;6738.7304507819135;7682.078150621737;7864.449488535747;8134;8293.30467598021;11381;12564.434600442819;12634.305113218861;12998.090133690552;13096.541621043218;10584.448214614476;10842.783144337227;10922.617708380169;10963.232573720083;11032.889671103187;10883.564657413932;11067.889321106686;11068.5572577096;11239.932206440375;11255.380954047607;10682.252242342962;11295.7740845181;11599.536018559163;11613.954744073075;11709.473073711533;7846.058472983279;8056.597170141352;8111.39164562672;8128.14654461273;8155.918440815516;9129.315301352557;11216.214864959375;11244.156688248251;11274.985251327093;11391.544338226378 19:51:25 INFO - PROCESS | 1637 | |3;mootools.html;1262.4382149943274;1312.4881296294443;1547.2418514927688;1792.5160206744188;1826.2786199451218;7622.199669034755;8010.519368837867;8020.238077382639;8020.719274825382;8026.638801253943;7146.071010768593;7369.410447164228;7389.741359052434;7442.665080071396;7920.247576480239;1824.3705921457076;1867.6638205123072;1868.8037756035624;1918.2231196365494;1989.3932350633052;1625.6911186874515;2030.604032213719;2035.3181684135832;2037.928672496463;2040.2043203150783;1972.6252012117723;1985.354759703095;1999.8600097993146;2005.1778770704013;2020.3433883987689;1692.458413307742;1781.26967943144;1855.2300795169988;1855.7680289963755;2025.5543780368369;1862.9441116766518;1864.8508119350556;1864.8974306413143;1973.753280839895;2039.75522937247;7916.445848790587;7965.641546130438;7976.282134607914;7978.6808527659405;7980.960095199545;4979.053979743873;5148.4851514848215;5150.407703114152;5169.172932330846;5181.663191892515;3043.421749867518;3119.142235885127;3221;3357.2278375973665;3361.1933136047173;941.2422999485411;961.567294717373;962.3552220012608;965.2374624046995;978.8238117138912;10814.891851081467;10893.455327233607;10988.670339889815;11002.954719301653;11025.228234023622;4236.894077648022;4248.660107191417;4381.277089280233;4395.922854002211;4406.713563618355;8657.91342086571;8658.220760131619;8661.913380866237;8686.609102590272;8690.478571285743;4946.703197808143;5059.367579052619;5065.316182315414;5072.213806859942;5074.2642316864585;4620.445546534437;4676.976615116971;4751.976240118777;4788.688735232199;4789.808407663654;3540.5751309842467;3596.7122630189524;3606.783592984377;3648.5074514940675;3659.0852286928266;986.9457179855033;1128.4075860173311;1128.4132251229314;1137.38581166171;1150.1718762490993;733.611186071383;840.9243168114899;841.6212704282975;854.2909385210261;877.4954401219325;5203.401608814959;5274.997750427407;5454.91817622736;5648.237487939158;5778.624389414675;407.1165570711563;421.3300851645898;427.88661004833745;437.7132977899481;439.9164158809816;3658.5975542690285;3749.362608356586;3754.530683664542;3843.7117216208894;3848.692104631623;9795.314327996972;10064.194864410829;10165.135963443043;10179.54192061359;10210.030047145508;10113.393196408239;10124.190064794799;10147.492625368703;10148.644797432054;10177.44024078668;6506.804795856132;7530.096388433423;7682.001339825787;7804.3366313862825;7848.21517848222;5354.437784032776;5457.426970168234;5488.067028605226;5564.55483561306;5721.22763426932;9321.161095501437;9325.953370233105;9414.011528789653;9421.528923553931;9507.572159252988;9338.486383248986;9617.422954622745;9763.218942484726;9763.951180244054;9765.755856103655;6721.1598550181225;6812.182538095461;6814.488913331619;6816.182058153054;6819.352161544645;7730.226977302224;7819.609019548886;7836.725714599962;7843;7902.2887940083365;6557.672116394257;6693.297203793726;7030.121234845645;7097.822554435974;7162.534435261691;6894.379505844498;6972.546784458994;6973.093497845248;7029.26192749754;7049.90726437403;6557.245916719638;6682.264950855305;6690.565113267622;6694.497912656473;6713.765018224339;4333.198358303724;4438.53395393492;4463.107378524373;4463.732176069446;4583.908321833478;4724.6692731508465;4749.738764367993;4813.470518242921;4862.902741945212;5007.824726134568 19:51:25 INFO - PROCESS | 1637 | |4;prototype.html;262.97107318195;282.68480644081853;286.301424524161;293.4966532396939;307.766097765698;4988.603191106491;5058.544730974211;5063.569596584285;5079.1365467870455;5090.363704536933;4295.251039334828;4986.326845875806;4992.400911890569;5210.19242017487;5222.459374484527;3487.424574945131;3747.2130852521004;3991.840326386948;4003.418649633393;4030.0051474520155;3576.159602493412;3703.703703703697;3943.6647884929816;3993.7204395692315;4014.8394064237395;3554.826907120657;3654.926901461969;3735.570409402926;3900.4929359183266;3923.136909879822;3711.480392745018;3910.843566257346;3913.9608603914166;3921.5294164700276;3938.5864484229314;3234.9029529113927;3394.55452715494;3396.3037577296595;3397.4394224952853;3402.812845293508;4062.9593704063172;4545.568171023748;4834.863807005351;4977.900441991176;5033.295338652591;3796.7532110413013;4202.810873510699;4415.337699345092;4489.73061616304;4517.864464066083;4610.354550362952;4832.565069143759;5487.506124448779;5502.3767988443105;5529.557635389159;3751.5498140223076;3756.380197267448;3757.7369584129124;3772.264408440355;3773.490578771858;4426.977865110686;5045.672031317916;5682.249715187956;5745.942540574624;5861.736221869984;3316.701496865294;3511.7892926424497;3744.812759362021;3751.606081361472;3792.4311353297226;3837.0599203195397;3842.8270727817317;3848.787631895944;3852.075501879529;3860.343741563941;3896.4155376693725;4092.508898932147;4332.003639162947;4467.955320446754;4490.5405743133615;5109.591232701375;5462.180672899097;5514.779408823602;5521.2270282160525;5553.916691249635;1117.9273347232404;1248.3945286536023;1249.843769528809;1254.5358217459598;1256.9497220111275;802.4102284820652;851.4678326046221;861.4572819124037;862.8835107260439;863.2230992107154;4363.650907927358;4916.606671466274;4929.802807887644;4944.826931057396;4977.784885725817;4322.184682433385;5357.517823395913;5363.436839131913;5368.677879327175;5450.264214331094;4168.145530166309;4478.776061196927;4897.2898929655;4913.901721965541;4934.111859865258;2416.6254230594286;2423.830331876787;2509.36011317113;2638.9736102639113;2785.470760555488;4996.775145118479;5411.565935027221;5487.731777493571;5623.212750214973;5636.239107720406;4752.310914917387;5230.843074707765;5436.374816896107;5507.879466405463;5862.882742345129;5954;5958.463738263577;5962.09482788774;5966.373530779292;6002.849928751729;5699.344575373885;5751.4536119068625;5754.395788442153;5761.02062649359;5765.769369225184;4478.888027799331;5322.8935421292135;5578.3584887738425;5659.688717120598;5678;4367.45406824147;5323.946760532345;5653.971730141488;5812.9709351452975;5923;3153.038323311412;3776.678162643053;3828.6599690108237;3852.4221366794086;3858.305505009125;5526.977509160818;5679.387481758437;5692.174634678031;5705.630648644378;5722.656640601577;4325.805338759827;4717.928227155752;5056.57019153376;5166;5562.638428502296;5035.093683137071;5057.544820966131;5115.2582875483595;5160.870978225575;5229.764660590358;4515.9548404515535;4975.477574854588;5153.727383111826;5436.075867102523;5459.808906688247;4835.685680430902;4856.805727770849;5478.45215478449;5540.556755459473;5547.697705452192;4339.698090572879;4519.288426943939;4910.901781964412;5417.8103766367985;5425.810096646598 19:51:25 INFO - PROCESS | 1637 | |5;yui.html;699.7306037175688;706.8511724357952;722.6350692900085;751.812046988253;795.153161882595;12364.752704945908;12881;12892.548760793374;12948.482060717572;13879.375428105734;12639.684007899807;12673.936630316835;12699.174553654006;12703.110782245247;12703.682407939807;642.3768944124204;818.5170749257936;821.1829229916242;822.6298165825402;827.8220182660726;638.0652344315577;650.9544331896769;660.8975608780647;801.7995501124719;833.891594092767;866.1208872993885;877.5875338590852;879.9912000880005;884.2616415293206;884.3367474394204;875.4178471316567;875.6891303587198;875.7898104454948;879.041844389612;879.2394578689419;506.62762869291043;514.7863636590811;632.2949910849416;655.672163918041;659.7888675623802;12329.198602090835;12434.191777534432;12513.311767852765;12516.687082823002;12517;10504.527296271686;10606.363618182933;10626.191625887976;10734.624288149877;10869.53261309721;9616.423014619146;9664.130228279488;9775.022497750168;9789.167920726746;10132.54403551842;3074.584931034304;3098.891538796154;3100.7519398448294;3113.2216945763557;3152.0543836849083;93756;94937;95288.52355738176;95922;101179.99999999926;8261.586920653943;8321.583920803936;8357.206065423776;8444;8606.159967210806;17390.826091739174;18418;18443.985580792916;18458.81541184598;18461.446156615322;7681.577513236825;7707.691692332356;7735.187805280365;7741.690332386642;7917.0895347034675;4139.234241665302;4250.426192463978;4250.617444430016;4259.893502662459;4363.2364336241035;3319.9170020749193;3386.779859309137;3412.5563676721868;3457.6542345765224;3469.7571170017854;630.9463695585835;636.5416899832113;640.6124294801671;650.778735230024;651.6415971215812;598.3029770317531;621.7233331167587;636.901280301554;649.0945131541473;676.9932300677028;8379.958100209582;8718.912810871938;8974.326925480615;8979.371443998987;9065.954670226607;556.9053260945649;586.3081563754725;627.244170774216;628.3465196195997;635.4090695652994;3945.5265368156006;4028.4964379452567;4252.851150209728;4390.187815254124;4423.380726698265;64645;84333;90386;108846.45576772223;115385;68434.97347539791;98765.50617246868;98921;103443;104201.95798042075;76756.84864726922;80835.5958220205;85576;89913;93836.53081734548;7016.508844381048;8337.583120844054;8391.916080839357;8411.606341609382;8811.471311721318;51561.484385155665;51758.482415175364;53121;53686.194707080205;54711;72377.10639146517;78569.60715196616;79223.60388198022;80601.19398805937;83007;11120.555177793121;11143.275687080313;11150.442477876237;11361;11431.256968297033;10209.540570674486;11991.280523168638;12000.63998080059;12270.202436841577;12352.62942111738;9392.765180870532;11611.5355385787;11749.236299640495;11751.823722643996;12152.453139608915;11553.711157221136;11722.413879306172;11794.174407791372;11880.702982425508;11912.642620721392;11562.132840036862;11694.2983420995;11716.472758725708;11759.176857619885;12192.634220973385;9624.615015399306;9637.807243854942;9692.75768105803;9825.705228843146;10157.238207134347;9701.466419346722;9952.402855828674;9965.451900145561;9976.401415915068;9981.201503879527 19:51:25 INFO - PROCESS | 1637 | __end_tp_report 19:51:25 INFO - PROCESS | 1637 | __start_cc_report 19:51:25 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1688 19:51:25 INFO - PROCESS | 1637 | __end_cc_report 19:51:25 INFO - PROCESS | 1637 | __startTimestamp1479354685551__endTimestamp 19:51:25 INFO - PROCESS | 1637 | 19:51:25 INFO - PROCESS | 1637 | ------- Summary: start ------- 19:51:25 INFO - PROCESS | 1637 | Number of tests: 6 19:51:25 INFO - PROCESS | 1637 | 19:51:25 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5767.57 Median:6025.94 stddev:660.37 (11.0%) stddev-sans-first:617.56 19:51:25 INFO - PROCESS | 1637 | Values: 2718.5 3351.9 3362.2 3388.4 3417.6 5607.7 5707.6 5729.1 5794.4 5809.2 5707.7 5753.5 5796.9 5799.3 5852.2 5170.3 5206.0 5222.8 5288.0 5315.8 5375.2 5381.8 5387.6 5406.5 5417.5 4450.8 5163.0 5325.2 5351.2 5433.2 5152.5 5171.6 5208.2 5280.9 5288.2 5166.5 5179.0 5184.8 5222.8 5226.7 5612.4 5625.2 5648.8 5659.2 5691.3 6082.8 6144.3 6161.8 6176.5 6177.1 6165.2 6196.3 6231.9 6234.1 6317.7 5792.3 5859.8 5865.6 5868.9 5890.5 6245.2 6299.9 6321.6 6329.4 6333.3 6120.2 6154.1 6158.1 6160.9 6171.9 6202.2 6233.8 6238.0 6270.7 6289.1 6218.7 6262.2 6271.6 6278.7 6286.2 6204.1 6262.1 6266.8 6271.7 6295.8 4861.2 4904.3 4913.6 4952.6 5003.0 4381.8 4470.6 4474.6 4503.3 4512.5 5772.5 5823.7 5877.9 5880.3 5927.9 6221.7 6231.0 6236.6 6241.9 6250.5 5866.5 5886.9 5889.9 5899.6 5908.2 5332.4 5377.3 5382.8 5383.3 5432.6 6370.3 6407.3 6408.9 6428.5 6432.5 6155.9 6245.6 6246.9 6248.8 6261.8 6196.0 6243.7 6277.6 6407.9 6415.3 6136.1 6171.7 6190.9 6213.3 6220.3 4837.9 6195.1 6209.9 6218.3 6253.1 6025.2 6099.0 6126.6 6161.9 6182.2 6097.4 6101.1 6108.5 6153.8 6170.0 6019.5 6042.2 6044.5 6047.1 6065.0 5994.3 6134.7 6136.7 6155.5 6157.0 5942.0 6010.8 6021.6 6025.9 6111.1 19:51:25 INFO - PROCESS | 1637 | 19:51:25 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:64107.46 Median:34072.57 stddev:143043.42 (419.8%) stddev-sans-first:143364.93 19:51:25 INFO - PROCESS | 1637 | Values: 482.8 510.1 520.7 523.7 531.5 25209.9 32092.0 33178.8 33205.0 33246.3 32944.2 33404.3 33487.5 33530.0 33636.8 7226.1 7407.2 7408.7 7412.9 7429.3 7615.0 7708.3 7711.0 7730.5 7732.0 7676.4 7742.7 7744.5 7748.7 7763.8 7664.8 7717.7 7730.5 7738.8 7750.9 7643.9 7716.5 7728.1 7730.5 7739.0 30801.0 31169.7 31192.0 31225.5 31293.7 3269.7 3324.6 3325.5 3712.2 3790.3 20961.0 21221.8 21462.8 22046.6 22116.8 2789.2 2846.1 2851.5 2851.7 2861.1 455751.0 456033.0 456760.0 459834.0 461298.7 59988.4 60342.8 60397.4 60419.4 60456.7 34030.3 34926.5 58611.8 58637.1 59053.0 15538.8 16076.7 16098.2 16132.2 16221.6 12288.3 12311.8 12351.0 12359.4 12392.9 18962.2 19017.8 19045.9 19057.7 19064.3 6365.9 6661.7 6849.6 7286.8 7726.7 738.1 825.1 955.5 986.3 1100.7 27095.3 27616.3 28803.9 29116.6 29488.7 1047.0 1062.3 1073.3 1084.2 1116.7 14604.9 14646.8 14983.3 15203.2 15226.2 477629.0 650707.0 650886.0 652041.0 654124.0 51808.7 52289.7 52297.0 52347.5 52575.5 1229.9 1267.1 1322.6 1335.0 1365.4 27992.6 28889.3 28974.9 29692.6 29873.7 49169.0 49617.8 49856.5 49863.0 49874.8 503599.0 510054.0 510179.0 512459.0 513222.4 21643.6 21797.0 24682.4 24711.9 24937.5 41172.2 41451.4 41605.0 41909.0 42292.6 34104.8 34122.7 34439.0 34938.8 35180.0 33606.0 34050.7 34094.5 34817.1 34942.8 33329.8 33371.0 33491.2 33502.0 35370.5 23254.1 29943.9 30796.0 31208.0 31361.4 17974.3 22083.2 22572.0 23017.4 23068.1 19:51:25 INFO - PROCESS | 1637 | 19:51:25 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:32102.49 Median:392.83 stddev:92165.39 (23461.7%) stddev-sans-first:92393.11 19:51:25 INFO - PROCESS | 1637 | Values: 352.3 369.7 373.5 382.4 403.3 12053.3 12353.6 12884.9 15792.5 16175.6 18905.5 19085.8 19177.3 19749.4 19933.0 4883.3 5261.2 5271.7 5272.7 5287.6 4344.5 4455.6 4775.5 4874.0 4893.8 4806.1 4812.3 4818.0 4818.2 4822.7 4599.4 4755.9 4820.2 4825.2 4825.5 4639.8 4672.2 4678.7 4683.3 4684.6 12030.3 12280.7 15015.1 20784.1 21021.6 2174.5 2290.1 2291.4 2313.9 2374.0 8380.0 8801.9 9186.4 9278.5 9422.0 1361.7 1680.8 1731.5 1740.3 1749.6 89111.6 109583.0 113549.0 113661.0 116399.0 8941.9 11291.9 11391.8 11413.7 11611.7 12870.9 14218.2 14249.6 14250.9 14263.3 6239.3 7255.3 8003.8 8082.4 8472.0 8077.8 8115.1 8154.1 8264.8 8302.3 3691.7 4352.8 4480.7 4555.4 4590.0 1842.9 1896.9 1898.5 1900.8 1906.8 864.9 866.4 900.4 927.4 939.9 16589.5 19655.3 19662.3 20667.5 20835.6 854.9 911.1 952.9 962.3 1015.6 8812.3 10211.9 10747.9 10824.4 10855.5 541434.0 545159.0 553468.0 558490.0 565839.0 65464.3 90776.2 96391.0 129144.0 131046.0 927.6 940.9 965.9 1015.1 1016.8 17622.8 17781.1 18037.7 18113.5 18482.0 55370.7 55669.4 56440.7 56584.4 57294.7 73316.6 78913.0 79417.6 80561.6 80630.2 6738.7 7682.1 7864.4 8134.0 8293.3 11381.0 12564.4 12634.3 12998.1 13096.5 10584.4 10842.8 10922.6 10963.2 11032.9 10883.6 11067.9 11068.6 11239.9 11255.4 10682.3 11295.8 11599.5 11614.0 11709.5 7846.1 8056.6 8111.4 8128.1 8155.9 9129.3 11216.2 11244.2 11275.0 11391.5 19:51:25 INFO - PROCESS | 1637 | 19:51:25 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5263.65 Median:5062.34 stddev:3028.93 (59.8%) stddev-sans-first:3022.51 19:51:25 INFO - PROCESS | 1637 | Values: 1262.4 1312.5 1547.2 1792.5 1826.3 7622.2 8010.5 8020.2 8020.7 8026.6 7146.1 7369.4 7389.7 7442.7 7920.2 1824.4 1867.7 1868.8 1918.2 1989.4 1625.7 2030.6 2035.3 2037.9 2040.2 1972.6 1985.4 1999.9 2005.2 2020.3 1692.5 1781.3 1855.2 1855.8 2025.6 1862.9 1864.9 1864.9 1973.8 2039.8 7916.4 7965.6 7976.3 7978.7 7981.0 4979.1 5148.5 5150.4 5169.2 5181.7 3043.4 3119.1 3221.0 3357.2 3361.2 941.2 961.6 962.4 965.2 978.8 10814.9 10893.5 10988.7 11003.0 11025.2 4236.9 4248.7 4381.3 4395.9 4406.7 8657.9 8658.2 8661.9 8686.6 8690.5 4946.7 5059.4 5065.3 5072.2 5074.3 4620.4 4677.0 4752.0 4788.7 4789.8 3540.6 3596.7 3606.8 3648.5 3659.1 986.9 1128.4 1128.4 1137.4 1150.2 733.6 840.9 841.6 854.3 877.5 5203.4 5275.0 5454.9 5648.2 5778.6 407.1 421.3 427.9 437.7 439.9 3658.6 3749.4 3754.5 3843.7 3848.7 9795.3 10064.2 10165.1 10179.5 10210.0 10113.4 10124.2 10147.5 10148.6 10177.4 6506.8 7530.1 7682.0 7804.3 7848.2 5354.4 5457.4 5488.1 5564.6 5721.2 9321.2 9326.0 9414.0 9421.5 9507.6 9338.5 9617.4 9763.2 9764.0 9765.8 6721.2 6812.2 6814.5 6816.2 6819.4 7730.2 7819.6 7836.7 7843.0 7902.3 6557.7 6693.3 7030.1 7097.8 7162.5 6894.4 6972.5 6973.1 7029.3 7049.9 6557.2 6682.3 6690.6 6694.5 6713.8 4333.2 4438.5 4463.1 4463.7 4583.9 4724.7 4749.7 4813.5 4862.9 5007.8 19:51:25 INFO - PROCESS | 1637 | 19:51:25 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4353.36 Median:4877.05 stddev:1360.50 (27.9%) stddev-sans-first:1329.23 19:51:25 INFO - PROCESS | 1637 | Values: 263.0 282.7 286.3 293.5 307.8 4988.6 5058.5 5063.6 5079.1 5090.4 4295.3 4986.3 4992.4 5210.2 5222.5 3487.4 3747.2 3991.8 4003.4 4030.0 3576.2 3703.7 3943.7 3993.7 4014.8 3554.8 3654.9 3735.6 3900.5 3923.1 3711.5 3910.8 3914.0 3921.5 3938.6 3234.9 3394.6 3396.3 3397.4 3402.8 4063.0 4545.6 4834.9 4977.9 5033.3 3796.8 4202.8 4415.3 4489.7 4517.9 4610.4 4832.6 5487.5 5502.4 5529.6 3751.5 3756.4 3757.7 3772.3 3773.5 4427.0 5045.7 5682.2 5745.9 5861.7 3316.7 3511.8 3744.8 3751.6 3792.4 3837.1 3842.8 3848.8 3852.1 3860.3 3896.4 4092.5 4332.0 4468.0 4490.5 5109.6 5462.2 5514.8 5521.2 5553.9 1117.9 1248.4 1249.8 1254.5 1256.9 802.4 851.5 861.5 862.9 863.2 4363.7 4916.6 4929.8 4944.8 4977.8 4322.2 5357.5 5363.4 5368.7 5450.3 4168.1 4478.8 4897.3 4913.9 4934.1 2416.6 2423.8 2509.4 2639.0 2785.5 4996.8 5411.6 5487.7 5623.2 5636.2 4752.3 5230.8 5436.4 5507.9 5862.9 5954.0 5958.5 5962.1 5966.4 6002.8 5699.3 5751.5 5754.4 5761.0 5765.8 4478.9 5322.9 5578.4 5659.7 5678.0 4367.5 5323.9 5654.0 5813.0 5923.0 3153.0 3776.7 3828.7 3852.4 3858.3 5527.0 5679.4 5692.2 5705.6 5722.7 4325.8 4717.9 5056.6 5166.0 5562.6 5035.1 5057.5 5115.3 5160.9 5229.8 4516.0 4975.5 5153.7 5436.1 5459.8 4835.7 4856.8 5478.5 5540.6 5547.7 4339.7 4519.3 4910.9 5417.8 5425.8 19:51:25 INFO - PROCESS | 1637 | 19:51:25 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19718.22 Median:633.85 stddev:29864.66 (4711.6%) stddev-sans-first:29914.30 19:51:25 INFO - PROCESS | 1637 | Values: 699.7 706.9 722.6 751.8 795.2 12364.8 12881.0 12892.5 12948.5 13879.4 12639.7 12673.9 12699.2 12703.1 12703.7 642.4 818.5 821.2 822.6 827.8 638.1 651.0 660.9 801.8 833.9 866.1 877.6 880.0 884.3 884.3 875.4 875.7 875.8 879.0 879.2 506.6 514.8 632.3 655.7 659.8 12329.2 12434.2 12513.3 12516.7 12517.0 10504.5 10606.4 10626.2 10734.6 10869.5 9616.4 9664.1 9775.0 9789.2 10132.5 3074.6 3098.9 3100.8 3113.2 3152.1 93756.0 94937.0 95288.5 95922.0 101180.0 8261.6 8321.6 8357.2 8444.0 8606.2 17390.8 18418.0 18444.0 18458.8 18461.4 7681.6 7707.7 7735.2 7741.7 7917.1 4139.2 4250.4 4250.6 4259.9 4363.2 3319.9 3386.8 3412.6 3457.7 3469.8 630.9 636.5 640.6 650.8 651.6 598.3 621.7 636.9 649.1 677.0 8380.0 8718.9 8974.3 8979.4 9066.0 556.9 586.3 627.2 628.3 635.4 3945.5 4028.5 4252.9 4390.2 4423.4 64645.0 84333.0 90386.0 108846.5 115385.0 68435.0 98765.5 98921.0 103443.0 104202.0 76756.8 80835.6 85576.0 89913.0 93836.5 7016.5 8337.6 8391.9 8411.6 8811.5 51561.5 51758.5 53121.0 53686.2 54711.0 72377.1 78569.6 79223.6 80601.2 83007.0 11120.6 11143.3 11150.4 11361.0 11431.3 10209.5 11991.3 12000.6 12270.2 12352.6 9392.8 11611.5 11749.2 11751.8 12152.5 11553.7 11722.4 11794.2 11880.7 11912.6 11562.1 11694.3 11716.5 11759.2 12192.6 9624.6 9637.8 9692.8 9825.7 10157.2 9701.5 9952.4 9965.5 9976.4 9981.2 19:51:25 INFO - PROCESS | 1637 | -------- Summary: end -------- 19:51:25 INFO - PROCESS | 1637 | 19:51:26 INFO - TEST-INFO | 1637: exit 0 19:51:26 INFO - TEST-OK | dromaeo_css | took 1118610ms 19:51:26 INFO - TEST-START | kraken 19:51:26 INFO - operating with platform_type : mac_ 19:51:26 INFO - Initialising browser for kraken test... 19:51:26 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpHMMbY2/profile http://localhost:49242/getInfo.html) 19:51:28 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 19:51:28 INFO - PROCESS | 1647 | colorDepth:24 19:51:28 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 19:51:28 INFO - PROCESS | 1647 | __metrics 19:51:28 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:51:28 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:51:29 INFO - TEST-INFO | 1647: exit 0 19:51:29 INFO - Browser initialized. 19:51:29 INFO - Running cycle 1/1 for kraken test... 19:51:29 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpHMMbY2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:51:41 INFO - PROCESS | 1648 | RSS: Main: 229400576 19:51:41 INFO - PROCESS | 1648 | 19:51:44 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 19:51:45 INFO - PROCESS | 1648 | RSS: Main: 288145408 19:51:45 INFO - PROCESS | 1648 | 19:51:47 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 19:51:48 INFO - PROCESS | 1648 | RSS: Main: 291160064 19:51:48 INFO - PROCESS | 1648 | 19:51:52 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 19:51:52 INFO - PROCESS | 1648 | RSS: Main: 378175488 19:51:52 INFO - PROCESS | 1648 | 19:51:54 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 19:51:55 INFO - PROCESS | 1648 | RSS: Main: 281264128 19:51:55 INFO - PROCESS | 1648 | 19:51:57 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:51:57 INFO - PROCESS | 1648 | RSS: Main: 285683712 19:51:57 INFO - PROCESS | 1648 | 19:52:00 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 19:52:01 INFO - PROCESS | 1648 | RSS: Main: 329076736 19:52:01 INFO - PROCESS | 1648 | 19:52:04 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 19:52:04 INFO - PROCESS | 1648 | RSS: Main: 330723328 19:52:04 INFO - PROCESS | 1648 | 19:52:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 19:52:08 INFO - PROCESS | 1648 | RSS: Main: 327327744 19:52:08 INFO - PROCESS | 1648 | 19:52:09 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:52:10 INFO - PROCESS | 1648 | RSS: Main: 303353856 19:52:10 INFO - PROCESS | 1648 | 19:52:12 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:52:13 INFO - PROCESS | 1648 | RSS: Main: 306049024 19:52:13 INFO - PROCESS | 1648 | 19:52:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:52:15 INFO - PROCESS | 1648 | RSS: Main: 308301824 19:52:15 INFO - PROCESS | 1648 | 19:52:18 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:52:19 INFO - PROCESS | 1648 | RSS: Main: 321003520 19:52:19 INFO - PROCESS | 1648 | 19:52:22 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:52:23 INFO - PROCESS | 1648 | RSS: Main: 320872448 19:52:23 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 19:52:25 INFO - PROCESS | 1648 | RSS: Main: 364335104 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | __start_tp_report 19:52:25 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 19:52:25 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 19:52:25 INFO - PROCESS | 1648 | |i|pagename|runs| 19:52:25 INFO - PROCESS | 1648 | |0;ai-astar;111;114;112;114;113;116;92;126;168;166 19:52:25 INFO - PROCESS | 1648 | |1;audio-beat-detection;143;116;112;150;114;95;117;138;177;118 19:52:25 INFO - PROCESS | 1648 | |2;audio-dft;186;185;185;181;181;183;185;185;257;196 19:52:25 INFO - PROCESS | 1648 | |3;audio-fft;82;58;60;86;60;58;59;58;81;58 19:52:25 INFO - PROCESS | 1648 | |4;audio-oscillator;86;71;91;68;68;69;90;68;68;92 19:52:25 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;119;120;87;85;133;118;88;84;87;83 19:52:25 INFO - PROCESS | 1648 | |6;imaging-darkroom;93;92;93;93;93;93;93;93;92;93 19:52:25 INFO - PROCESS | 1648 | |7;imaging-desaturate;87;86;86;87;84;86;88;86;88;85 19:52:25 INFO - PROCESS | 1648 | |8;json-parse-financial;55;53;54;55;55;56;55;55;55;53 19:52:25 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;70;73;79;75;73;70;70;71;70;72 19:52:25 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;88;86;87;89;86;86;89;86;85;86 19:52:25 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;150;148;147;147;144;136;160;173;219;163 19:52:25 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;217;173;181;233;232;189;181;234;203;175 19:52:25 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;67;68;67;68;68;69;67;67;66;68 19:52:25 INFO - PROCESS | 1648 | __end_tp_report 19:52:25 INFO - PROCESS | 1648 | __start_cc_report 19:52:25 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1956 19:52:25 INFO - PROCESS | 1648 | __end_cc_report 19:52:25 INFO - PROCESS | 1648 | __startTimestamp1479354745428__endTimestamp 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | ------- Summary: start ------- 19:52:25 INFO - PROCESS | 1648 | Number of tests: 14 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:123.20 Median:121.00 stddev:24.54 (20.3%) stddev-sans-first:25.63 19:52:25 INFO - PROCESS | 1648 | Values: 111.0 114.0 112.0 114.0 113.0 116.0 92.0 126.0 168.0 166.0 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:140.50 stddev:23.84 (17.0%) stddev-sans-first:24.66 19:52:25 INFO - PROCESS | 1648 | Values: 143.0 116.0 112.0 150.0 114.0 95.0 117.0 138.0 177.0 118.0 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:192.40 Median:185.00 stddev:23.08 (12.5%) stddev-sans-first:24.36 19:52:25 INFO - PROCESS | 1648 | Values: 186.0 185.0 185.0 181.0 181.0 183.0 185.0 185.0 257.0 196.0 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.00 stddev:11.82 (19.7%) stddev-sans-first:11.03 19:52:25 INFO - PROCESS | 1648 | Values: 82.0 58.0 60.0 86.0 60.0 58.0 59.0 58.0 81.0 58.0 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:78.50 stddev:11.03 (14.1%) stddev-sans-first:11.22 19:52:25 INFO - PROCESS | 1648 | Values: 86.0 71.0 91.0 68.0 68.0 69.0 90.0 68.0 68.0 92.0 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:100.40 Median:84.50 stddev:19.51 (23.1%) stddev-sans-first:19.49 19:52:25 INFO - PROCESS | 1648 | Values: 119.0 120.0 87.0 85.0 133.0 118.0 88.0 84.0 87.0 83.0 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:92.80 Median:93.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 19:52:25 INFO - PROCESS | 1648 | Values: 93.0 92.0 93.0 93.0 93.0 93.0 93.0 93.0 92.0 93.0 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.50 stddev:1.25 (1.4%) stddev-sans-first:1.30 19:52:25 INFO - PROCESS | 1648 | Values: 87.0 86.0 86.0 87.0 84.0 86.0 88.0 86.0 88.0 85.0 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 19:52:25 INFO - PROCESS | 1648 | Values: 55.0 53.0 54.0 55.0 55.0 56.0 55.0 55.0 55.0 53.0 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:72.50 stddev:2.91 (4.0%) stddev-sans-first:2.96 19:52:25 INFO - PROCESS | 1648 | Values: 70.0 73.0 79.0 75.0 73.0 70.0 70.0 71.0 70.0 72.0 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:1.40 (1.6%) stddev-sans-first:1.41 19:52:25 INFO - PROCESS | 1648 | Values: 88.0 86.0 87.0 89.0 86.0 86.0 89.0 86.0 85.0 86.0 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:158.70 Median:155.00 stddev:23.70 (15.3%) stddev-sans-first:24.93 19:52:25 INFO - PROCESS | 1648 | Values: 150.0 148.0 147.0 147.0 144.0 136.0 160.0 173.0 219.0 163.0 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.80 Median:210.00 stddev:25.24 (12.0%) stddev-sans-first:26.16 19:52:25 INFO - PROCESS | 1648 | Values: 217.0 173.0 181.0 233.0 232.0 189.0 181.0 234.0 203.0 175.0 19:52:25 INFO - PROCESS | 1648 | 19:52:25 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 19:52:25 INFO - PROCESS | 1648 | Values: 67.0 68.0 67.0 68.0 68.0 69.0 67.0 67.0 66.0 68.0 19:52:25 INFO - PROCESS | 1648 | -------- Summary: end -------- 19:52:25 INFO - PROCESS | 1648 | 19:52:26 INFO - TEST-INFO | 1648: exit 0 19:52:26 INFO - TEST-OK | kraken | took 60080ms 19:52:26 INFO - SUITE-END | took 1178s 19:52:26 INFO - Completed test suite (00:19:38) 19:52:26 INFO - javascript benchmark 19:52:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2718.456308738252, 3351.8826841060554, 3362.17626681463, 3388.440907250304, 3417.6240613532523, 5607.691576963265, 5707.6290041147295, 5729.111987641917, 5794.420557944209, 5809.244798176236, 5707.71461426928, 5753.510951569111, 5796.855078623036, 5799.304083509975, 5852.151438041481, 5170.276161337416, 5205.973970130144, 5222.843314700546, 5287.995280896636, 5315.840524784263, 5375.247465354853, 5381.81163659272, 5387.595930305223, 5406.513413792758, 5417.485338892819, 4450.777461126947, 5162.974185129088, 5325.201219817059, 5351.197320401932, 5433.212184233304, 5152.458991805844, 5171.637985341028, 5208.166693329087, 5280.947190528084, 5288.206768984644, 5166.457521960216, 5178.974105129488, 5184.766685499161, 5222.791088356461, 5226.686398816045, 5612.438756124396, 5625.212470254168, 5648.774049038034, 5659.207710920475, 5691.345495268056, 6082.813851298998, 6144.279601711528, 6161.815145545596, 6176.536759742992, 6177.073438984144, 6165.198524191826, 6196.349383314732, 6231.937680623181, 6234.064890266451, 6317.715702793385, 5792.333881603669, 5859.765609375662, 5865.648061116347, 5868.911966320508, 5890.469857712784, 6245.219347581552, 6299.937000629935, 6321.620702757849, 6329.4303512683155, 6333.334999825044, 6120.204373431426, 6154.076888466766, 6158.076288556663, 6160.876782464416, 6171.938280617226, 6202.1937148171355, 6233.844153896189, 6238.0, 6270.655113968684, 6289.056641503719, 6218.689065546704, 6262.185915830913, 6271.560990730696, 6278.6860656966965, 6286.182796236551, 6204.13142160098, 6262.091996660459, 6266.811995640138, 6271.717772700239, 6295.842603934938, 4861.173600487926, 4904.2643603459765, 4913.606911447076, 4952.62855285855, 5002.974985125124, 4381.84663536781, 4470.552944705503, 4474.574915383034, 4503.301988191835, 4512.458504979423, 5772.509336706427, 5823.650580965155, 5877.9118313225335, 5880.323762767251, 5927.9407205928255, 6221.666874921904, 6230.968845155745, 6236.563440559208, 6241.875162496724, 6250.468710159687, 5866.50134738552, 5886.852828679317, 5889.882202355929, 5899.557533185029, 5908.20239267702, 5332.413434522199, 5377.274068000848, 5382.811601593926, 5383.300170977826, 5432.619716619799, 6370.299267080617, 6407.327230640809, 6408.935910640834, 6428.4857211423905, 6432.549721519449, 6155.907661384993, 6245.594036387621, 6246.906296405648, 6248.812535623939, 6261.78083767066, 6195.96902015487, 6243.687815609111, 6277.591956522811, 6407.871842563216, 6415.3263907289065, 6136.110264011604, 6171.660558669317, 6190.938090619036, 6213.347598502092, 6220.253569571681, 4837.903241935212, 6195.132681424694, 6209.875802484015, 6218.253809542884, 6253.09330147117, 6025.246844144482, 6099.024156134997, 6126.632402055712, 6161.876762464636, 6182.227221597301, 6097.359777223328, 6101.145839582551, 6108.480779133645, 6153.84615384619, 6169.96915015422, 6019.458248757633, 6042.214512113573, 6044.455998960115, 6047.123167140828, 6065.0, 5994.310654274815, 6134.693265336805, 6136.693165341804, 6155.507559395327, 6156.969215154075, 5942.019566771607, 6010.759569617341, 6021.638701677914, 6025.939740602538, 6111.113888486234], "value": 5723.473864896234, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.76585855859923, 510.1404134034152, 520.6927912531605, 523.6674711558162, 531.4924247343787, 25209.873950630245, 32092.03723888284, 33178.8341058295, 33205.0, 33246.33507329852, 32944.17639559012, 33404.33191336178, 33487.49768753465, 33530.0, 33636.82271120511, 7226.096737907775, 7407.222241664628, 7408.666610002563, 7412.888806667905, 7429.331360177583, 7615.0, 7708.30625243728, 7710.961445192795, 7730.458867879251, 7731.961340193291, 7676.385889128885, 7742.690292388326, 7744.457887947846, 7748.728794492194, 7763.844723105534, 7664.846703065935, 7717.652705628204, 7730.458867879251, 7738.845223095506, 7750.883736743954, 7643.923560764432, 7716.459847810655, 7728.111267204287, 7730.497517661334, 7739.032620922385, 30801.0, 31169.688303116905, 31192.0, 31225.53161702576, 31293.687063129306, 3269.6893795089427, 3324.6010478742705, 3325.5006383729065, 3712.201876596545, 3790.33669107905, 20961.0, 21221.78778212229, 21462.785372146234, 22046.559068818693, 22116.778832211632, 2789.17719272815, 2846.117703511918, 2851.5152424087955, 2851.743343099131, 2861.1130549529503, 455751.0, 456033.0, 456760.0, 459834.0, 461298.6935065337, 59988.40011599828, 60342.79314413687, 60397.396026040056, 60419.39580604226, 60456.69771651202, 34030.319393611986, 34926.476102858476, 58611.82776344449, 58637.12044319339, 59053.0, 15538.844611553739, 16076.678466430605, 16098.195090245441, 16132.193390330436, 16221.59446013859, 12288.324142172087, 12311.753764924651, 12351.0, 12359.3820308986, 12392.876071239352, 18962.24151033943, 19017.80982190188, 19045.90477047606, 19057.714134287995, 19064.33274835374, 6365.872682546323, 6661.667666466629, 6849.554778939353, 7286.781396558112, 7726.652300646484, 738.1499682942303, 825.0553116681366, 955.460165006769, 986.3292960786733, 1100.6918062942389, 27095.32261693434, 27616.309592259953, 28803.855980719964, 29116.57527330517, 29488.705112949025, 1047.0, 1062.2829590026702, 1073.3184427888348, 1084.1543595994979, 1116.7264020315074, 14604.853951460349, 14646.84832370407, 14983.250837458083, 15203.209246442773, 15226.162561059247, 477629.0, 650707.0, 650886.0, 652041.0, 654124.0, 51808.740956294976, 52289.738551307, 52297.0, 52347.47652523502, 52575.47424525706, 1229.9077569182348, 1267.087696858279, 1322.6494978830426, 1334.9532766353132, 1365.4128724648497, 27992.58011129794, 28889.277768055967, 28974.855125724236, 29692.55461168041, 29873.70126298709, 49169.0, 49617.751911241656, 49856.501434985184, 49863.0, 49874.750626246634, 503599.0, 510054.0, 510179.0, 512459.0, 513222.4338878282, 21643.637090527598, 21797.019134138685, 24682.382940426633, 24711.87644061768, 24937.501249975263, 41172.176556469305, 41451.37822932598, 41605.0, 41909.0, 42292.577074228866, 34104.829475852464, 34122.658773411946, 34439.0, 34938.82530587432, 35180.0, 33606.0, 34050.65949340574, 34094.48858267078, 34817.12957176091, 34942.82528587442, 33329.83335083309, 33370.99887003394, 33491.162720932174, 33501.99494015183, 35370.46944295786, 23254.069837207, 29943.85028074846, 30796.0, 31208.0, 31361.372772544877, 17974.2810287587, 22083.227087051877, 22572.0, 23017.424564386023, 23068.077276908734], "value": 17827.25394702849, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.3094734320731, 369.67653303359555, 373.48086160237256, 382.38245233947174, 403.2841705971899, 12053.276803391791, 12353.629391118258, 12884.871151288497, 15792.526224213263, 16175.595610109753, 18905.527361815963, 19085.809141908576, 19177.27404533592, 19749.40751777449, 19933.003349832525, 4883.316335712994, 5261.158214685651, 5271.736413179345, 5272.683638981654, 5287.550558202557, 4344.522102568731, 4455.598996090352, 4775.474697783241, 4873.975630121844, 4893.779779909913, 4806.134895718769, 4812.278158276252, 4818.0005297801545, 4818.204996175645, 4822.6624136310475, 4599.44806623204, 4755.857324280277, 4820.156472617296, 4825.203841366153, 4825.469198388209, 4639.8144074237325, 4672.2057250267535, 4678.672492925497, 4683.250679891235, 4684.601808846252, 12030.27818330903, 12280.692982675415, 15015.07206094812, 20784.064717087767, 21021.5795684087, 2174.510735084609, 2290.1068583252545, 2291.3584196425027, 2313.8611683299055, 2374.0112432217234, 8379.95810020946, 8801.867971980426, 9186.356955013152, 9278.536073196314, 9421.952890235574, 1361.748076605821, 1680.7562903378941, 1731.5151757507917, 1740.295180451919, 1749.6063385738235, 89111.55444222737, 109583.0, 113549.0, 113660.99999999917, 116399.0, 8941.910580894108, 11291.943540282246, 11391.772164556829, 11413.65759027214, 11611.6516504505, 12870.871291287154, 14218.217998010208, 14249.572512824425, 14250.857491424953, 14263.286835658384, 6239.251289845248, 7255.347018768336, 8003.839923201504, 8082.434229603871, 8472.025717042496, 8077.798055048554, 8115.1073381927945, 8154.103048664642, 8264.752057438287, 8302.294304984023, 3691.7415780895617, 4352.804123814436, 4480.731156130642, 4555.385023021916, 4590.0, 1842.8525717942532, 1896.933607323737, 1898.5443493561445, 1900.8194221548931, 1906.7606056063669, 864.943778654398, 866.3978534918298, 900.4147304252158, 927.4296307770672, 939.8872135343803, 16589.50231493033, 19655.312064077687, 19662.311819086262, 20667.4833129173, 20835.583288334452, 854.9016863060828, 911.1207684584408, 952.880365570452, 962.259060523393, 1015.619142821442, 8812.295016398673, 10211.948940255252, 10747.892521074846, 10824.350538967687, 10855.51150198243, 541434.0, 545159.0, 553468.0, 558490.0, 565839.0, 65464.345356545826, 90776.23107621523, 96391.0, 129144.0, 131046.0, 927.5501381829807, 940.8635747816528, 965.9275554333312, 1015.0914931136591, 1016.8474728790593, 17622.82377176212, 17781.110944452983, 18037.72943405876, 18113.45659630213, 18482.0, 55370.72314638562, 55669.44330556643, 56440.717796410754, 56584.43415565956, 57294.713526432104, 73316.63341683257, 78913.0, 79417.60291198739, 80561.59719201367, 80630.19369806227, 6738.7304507819135, 7682.078150621737, 7864.449488535747, 8134.0, 8293.30467598021, 11381.0, 12564.434600442819, 12634.305113218861, 12998.090133690552, 13096.541621043218, 10584.448214614476, 10842.783144337227, 10922.617708380169, 10963.232573720083, 11032.889671103187, 10883.564657413932, 11067.889321106686, 11068.5572577096, 11239.932206440375, 11255.380954047607, 10682.252242342962, 11295.7740845181, 11599.536018559163, 11613.954744073075, 11709.473073711533, 7846.058472983279, 8056.597170141352, 8111.39164562672, 8128.14654461273, 8155.918440815516, 9129.315301352557, 11216.214864959375, 11244.156688248251, 11274.985251327093, 11391.544338226378], "value": 8816.042412516572, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1262.4382149943274, 1312.4881296294443, 1547.2418514927688, 1792.5160206744188, 1826.2786199451218, 7622.199669034755, 8010.519368837867, 8020.238077382639, 8020.719274825382, 8026.638801253943, 7146.071010768593, 7369.410447164228, 7389.741359052434, 7442.665080071396, 7920.247576480239, 1824.3705921457076, 1867.6638205123072, 1868.8037756035624, 1918.2231196365494, 1989.3932350633052, 1625.6911186874515, 2030.604032213719, 2035.3181684135832, 2037.928672496463, 2040.2043203150783, 1972.6252012117723, 1985.354759703095, 1999.8600097993146, 2005.1778770704013, 2020.3433883987689, 1692.458413307742, 1781.26967943144, 1855.2300795169988, 1855.7680289963755, 2025.5543780368369, 1862.9441116766518, 1864.8508119350556, 1864.8974306413143, 1973.753280839895, 2039.75522937247, 7916.445848790587, 7965.641546130438, 7976.282134607914, 7978.6808527659405, 7980.960095199545, 4979.053979743873, 5148.4851514848215, 5150.407703114152, 5169.172932330846, 5181.663191892515, 3043.421749867518, 3119.142235885127, 3221.0, 3357.2278375973665, 3361.1933136047173, 941.2422999485411, 961.567294717373, 962.3552220012608, 965.2374624046995, 978.8238117138912, 10814.891851081467, 10893.455327233607, 10988.670339889815, 11002.954719301653, 11025.228234023622, 4236.894077648022, 4248.660107191417, 4381.277089280233, 4395.922854002211, 4406.713563618355, 8657.91342086571, 8658.220760131619, 8661.913380866237, 8686.609102590272, 8690.478571285743, 4946.703197808143, 5059.367579052619, 5065.316182315414, 5072.213806859942, 5074.2642316864585, 4620.445546534437, 4676.976615116971, 4751.976240118777, 4788.688735232199, 4789.808407663654, 3540.5751309842467, 3596.7122630189524, 3606.783592984377, 3648.5074514940675, 3659.0852286928266, 986.9457179855033, 1128.4075860173311, 1128.4132251229314, 1137.38581166171, 1150.1718762490993, 733.611186071383, 840.9243168114899, 841.6212704282975, 854.2909385210261, 877.4954401219325, 5203.401608814959, 5274.997750427407, 5454.91817622736, 5648.237487939158, 5778.624389414675, 407.1165570711563, 421.3300851645898, 427.88661004833745, 437.7132977899481, 439.9164158809816, 3658.5975542690285, 3749.362608356586, 3754.530683664542, 3843.7117216208894, 3848.692104631623, 9795.314327996972, 10064.194864410829, 10165.135963443043, 10179.54192061359, 10210.030047145508, 10113.393196408239, 10124.190064794799, 10147.492625368703, 10148.644797432054, 10177.44024078668, 6506.804795856132, 7530.096388433423, 7682.001339825787, 7804.3366313862825, 7848.21517848222, 5354.437784032776, 5457.426970168234, 5488.067028605226, 5564.55483561306, 5721.22763426932, 9321.161095501437, 9325.953370233105, 9414.011528789653, 9421.528923553931, 9507.572159252988, 9338.486383248986, 9617.422954622745, 9763.218942484726, 9763.951180244054, 9765.755856103655, 6721.1598550181225, 6812.182538095461, 6814.488913331619, 6816.182058153054, 6819.352161544645, 7730.226977302224, 7819.609019548886, 7836.725714599962, 7843.0, 7902.2887940083365, 6557.672116394257, 6693.297203793726, 7030.121234845645, 7097.822554435974, 7162.534435261691, 6894.379505844498, 6972.546784458994, 6973.093497845248, 7029.26192749754, 7049.90726437403, 6557.245916719638, 6682.264950855305, 6690.565113267622, 6694.497912656473, 6713.765018224339, 4333.198358303724, 4438.53395393492, 4463.107378524373, 4463.732176069446, 4583.908321833478, 4724.6692731508465, 4749.738764367993, 4813.470518242921, 4862.902741945212, 5007.824726134568], "value": 4107.443050259674, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.97107318195, 282.68480644081853, 286.301424524161, 293.4966532396939, 307.766097765698, 4988.603191106491, 5058.544730974211, 5063.569596584285, 5079.1365467870455, 5090.363704536933, 4295.251039334828, 4986.326845875806, 4992.400911890569, 5210.19242017487, 5222.459374484527, 3487.424574945131, 3747.2130852521004, 3991.840326386948, 4003.418649633393, 4030.0051474520155, 3576.159602493412, 3703.703703703697, 3943.6647884929816, 3993.7204395692315, 4014.8394064237395, 3554.826907120657, 3654.926901461969, 3735.570409402926, 3900.4929359183266, 3923.136909879822, 3711.480392745018, 3910.843566257346, 3913.9608603914166, 3921.5294164700276, 3938.5864484229314, 3234.9029529113927, 3394.55452715494, 3396.3037577296595, 3397.4394224952853, 3402.812845293508, 4062.9593704063172, 4545.568171023748, 4834.863807005351, 4977.900441991176, 5033.295338652591, 3796.7532110413013, 4202.810873510699, 4415.337699345092, 4489.73061616304, 4517.864464066083, 4610.354550362952, 4832.565069143759, 5487.506124448779, 5502.3767988443105, 5529.557635389159, 3751.5498140223076, 3756.380197267448, 3757.7369584129124, 3772.264408440355, 3773.490578771858, 4426.977865110686, 5045.672031317916, 5682.249715187956, 5745.942540574624, 5861.736221869984, 3316.701496865294, 3511.7892926424497, 3744.812759362021, 3751.606081361472, 3792.4311353297226, 3837.0599203195397, 3842.8270727817317, 3848.787631895944, 3852.075501879529, 3860.343741563941, 3896.4155376693725, 4092.508898932147, 4332.003639162947, 4467.955320446754, 4490.5405743133615, 5109.591232701375, 5462.180672899097, 5514.779408823602, 5521.2270282160525, 5553.916691249635, 1117.9273347232404, 1248.3945286536023, 1249.843769528809, 1254.5358217459598, 1256.9497220111275, 802.4102284820652, 851.4678326046221, 861.4572819124037, 862.8835107260439, 863.2230992107154, 4363.650907927358, 4916.606671466274, 4929.802807887644, 4944.826931057396, 4977.784885725817, 4322.184682433385, 5357.517823395913, 5363.436839131913, 5368.677879327175, 5450.264214331094, 4168.145530166309, 4478.776061196927, 4897.2898929655, 4913.901721965541, 4934.111859865258, 2416.6254230594286, 2423.830331876787, 2509.36011317113, 2638.9736102639113, 2785.470760555488, 4996.775145118479, 5411.565935027221, 5487.731777493571, 5623.212750214973, 5636.239107720406, 4752.310914917387, 5230.843074707765, 5436.374816896107, 5507.879466405463, 5862.882742345129, 5954.0, 5958.463738263577, 5962.09482788774, 5966.373530779292, 6002.849928751729, 5699.344575373885, 5751.4536119068625, 5754.395788442153, 5761.02062649359, 5765.769369225184, 4478.888027799331, 5322.8935421292135, 5578.3584887738425, 5659.688717120598, 5678.0, 4367.45406824147, 5323.946760532345, 5653.971730141488, 5812.9709351452975, 5923.0, 3153.038323311412, 3776.678162643053, 3828.6599690108237, 3852.4221366794086, 3858.305505009125, 5526.977509160818, 5679.387481758437, 5692.174634678031, 5705.630648644378, 5722.656640601577, 4325.805338759827, 4717.928227155752, 5056.57019153376, 5166.0, 5562.638428502296, 5035.093683137071, 5057.544820966131, 5115.2582875483595, 5160.870978225575, 5229.764660590358, 4515.9548404515535, 4975.477574854588, 5153.727383111826, 5436.075867102523, 5459.808906688247, 4835.685680430902, 4856.805727770849, 5478.45215478449, 5540.556755459473, 5547.697705452192, 4339.698090572879, 4519.288426943939, 4910.901781964412, 5417.8103766367985, 5425.810096646598], "value": 3917.2999693249644, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.7306037175688, 706.8511724357952, 722.6350692900085, 751.812046988253, 795.153161882595, 12364.752704945908, 12881.0, 12892.548760793374, 12948.482060717572, 13879.375428105734, 12639.684007899807, 12673.936630316835, 12699.174553654006, 12703.110782245247, 12703.682407939807, 642.3768944124204, 818.5170749257936, 821.1829229916242, 822.6298165825402, 827.8220182660726, 638.0652344315577, 650.9544331896769, 660.8975608780647, 801.7995501124719, 833.891594092767, 866.1208872993885, 877.5875338590852, 879.9912000880005, 884.2616415293206, 884.3367474394204, 875.4178471316567, 875.6891303587198, 875.7898104454948, 879.041844389612, 879.2394578689419, 506.62762869291043, 514.7863636590811, 632.2949910849416, 655.672163918041, 659.7888675623802, 12329.198602090835, 12434.191777534432, 12513.311767852765, 12516.687082823002, 12517.0, 10504.527296271686, 10606.363618182933, 10626.191625887976, 10734.624288149877, 10869.53261309721, 9616.423014619146, 9664.130228279488, 9775.022497750168, 9789.167920726746, 10132.54403551842, 3074.584931034304, 3098.891538796154, 3100.7519398448294, 3113.2216945763557, 3152.0543836849083, 93756.0, 94937.0, 95288.52355738176, 95922.0, 101179.99999999926, 8261.586920653943, 8321.583920803936, 8357.206065423776, 8444.0, 8606.159967210806, 17390.826091739174, 18418.0, 18443.985580792916, 18458.81541184598, 18461.446156615322, 7681.577513236825, 7707.691692332356, 7735.187805280365, 7741.690332386642, 7917.0895347034675, 4139.234241665302, 4250.426192463978, 4250.617444430016, 4259.893502662459, 4363.2364336241035, 3319.9170020749193, 3386.779859309137, 3412.5563676721868, 3457.6542345765224, 3469.7571170017854, 630.9463695585835, 636.5416899832113, 640.6124294801671, 650.778735230024, 651.6415971215812, 598.3029770317531, 621.7233331167587, 636.901280301554, 649.0945131541473, 676.9932300677028, 8379.958100209582, 8718.912810871938, 8974.326925480615, 8979.371443998987, 9065.954670226607, 556.9053260945649, 586.3081563754725, 627.244170774216, 628.3465196195997, 635.4090695652994, 3945.5265368156006, 4028.4964379452567, 4252.851150209728, 4390.187815254124, 4423.380726698265, 64645.0, 84333.0, 90386.0, 108846.45576772223, 115385.0, 68434.97347539791, 98765.50617246868, 98921.0, 103443.0, 104201.95798042075, 76756.84864726922, 80835.5958220205, 85576.0, 89913.0, 93836.53081734548, 7016.508844381048, 8337.583120844054, 8391.916080839357, 8411.606341609382, 8811.471311721318, 51561.484385155665, 51758.482415175364, 53121.0, 53686.194707080205, 54711.0, 72377.10639146517, 78569.60715196616, 79223.60388198022, 80601.19398805937, 83007.0, 11120.555177793121, 11143.275687080313, 11150.442477876237, 11361.0, 11431.256968297033, 10209.540570674486, 11991.280523168638, 12000.63998080059, 12270.202436841577, 12352.62942111738, 9392.765180870532, 11611.5355385787, 11749.236299640495, 11751.823722643996, 12152.453139608915, 11553.711157221136, 11722.413879306172, 11794.174407791372, 11880.702982425508, 11912.642620721392, 11562.132840036862, 11694.2983420995, 11716.472758725708, 11759.176857619885, 12192.634220973385, 9624.615015399306, 9637.807243854942, 9692.75768105803, 9825.705228843146, 10157.238207134347, 9701.466419346722, 9952.402855828674, 9965.451900145561, 9976.401415915068, 9981.201503879527], "value": 6814.7258207296445, "unit": "score"}], "name": "dromaeo_css", "value": 6797.436785633287, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 112.0, 114.0, 113.0, 116.0, 92.0, 126.0, 168.0, 166.0], "value": 123.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 116.0, 112.0, 150.0, 114.0, 95.0, 117.0, 138.0, 177.0, 118.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 185.0, 181.0, 181.0, 183.0, 185.0, 185.0, 257.0, 196.0], "value": 192.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 86.0, 60.0, 58.0, 59.0, 58.0, 81.0, 58.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 91.0, 68.0, 68.0, 69.0, 90.0, 68.0, 68.0, 92.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 87.0, 85.0, 133.0, 118.0, 88.0, 84.0, 87.0, 83.0], "value": 100.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 92.0, 93.0], "value": 92.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 87.0, 84.0, 86.0, 88.0, 86.0, 88.0, 85.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 55.0, 55.0, 56.0, 55.0, 55.0, 55.0, 53.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 79.0, 75.0, 73.0, 70.0, 70.0, 71.0, 70.0, 72.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 89.0, 86.0, 86.0, 89.0, 86.0, 85.0, 86.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 147.0, 147.0, 144.0, 136.0, 160.0, 173.0, 219.0, 163.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 173.0, 181.0, 233.0, 232.0, 189.0, 181.0, 234.0, 203.0, 175.0], "value": 201.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 69.0, 67.0, 67.0, 66.0, 68.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1507.8999999999999, "alertThreshold": 2.0}]} 19:52:26 INFO - Return code: 0 19:52:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:52:26 INFO - # TBPL SUCCESS # 19:52:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:52:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:52:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:52:26 INFO - 2016-11-16 19:52:26.754 screenresolution[1652:9797] starting screenresolution argv=screenresolution get 19:52:26 INFO - 2016-11-16 19:52:26.757 screenresolution[1652:9797] Display 0: 1600x1200x32@60 19:52:26 INFO - 2016-11-16 19:52:26.763 screenresolution[1653:9800] starting screenresolution argv=screenresolution list 19:52:26 INFO - Available Modes on Display 0 19:52:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:52:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:52:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:52:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:52:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:52:26 INFO - Intel Iris: 19:52:26 INFO - Chipset Model: Intel Iris 19:52:26 INFO - Type: GPU 19:52:26 INFO - Bus: Built-In 19:52:26 INFO - VRAM (Dynamic, Max): 1536 MB 19:52:26 INFO - Vendor: Intel (0x8086) 19:52:26 INFO - Device ID: 0x0a2e 19:52:26 INFO - Revision ID: 0x0009 19:52:26 INFO - Displays: 19:52:26 INFO - Display: 19:52:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:52:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:52:26 INFO - Display Serial Number: 1600x1200 60 19:52:26 INFO - Main Display: Yes 19:52:26 INFO - Mirror: Off 19:52:26 INFO - Online: Yes 19:52:26 INFO - Rotation: Supported 19:52:26 INFO - Return code: 0 19:52:26 INFO - Running post-action listener: _resource_record_post_action 19:52:26 INFO - [mozharness: 2016-11-17 03:52:26.998061Z] Finished run-tests step (success) 19:52:26 INFO - Running post-run listener: _resource_record_post_run 19:52:27 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 38716416; Write bytes: 700762112; Read time: 375; Write time: 1987 19:52:27 INFO - TinderboxPrint: CPU usage
53.7% 19:52:27 INFO - TinderboxPrint: I/O read bytes / time
38,716,416 / 375 19:52:27 INFO - TinderboxPrint: I/O write bytes / time
700,762,112 / 1,987 19:52:27 INFO - TinderboxPrint: CPU idle
2,249.4 (46.3%) 19:52:27 INFO - TinderboxPrint: CPU system
974.8 (20.1%) 19:52:27 INFO - TinderboxPrint: CPU user
1,629.5 (33.6%) 19:52:27 INFO - TinderboxPrint: Swap in / out
436,944,896 / 0 19:52:27 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399274496; Write bytes: 392509440; Read time: 30106; Write time: 742 19:52:27 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34497536; Write bytes: 298008576; Read time: 342; Write time: 1209 19:52:27 INFO - Running post-run listener: _upload_blobber_files 19:52:27 INFO - Blob upload gear active. 19:52:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:52:27 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 19:52:27 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:52:27 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:52:27 INFO - (blobuploader) - INFO - Open directory for files ... 19:52:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:52:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:52:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:52:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:52:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:52:28 INFO - (blobuploader) - INFO - Done attempting. 19:52:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:52:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:52:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:52:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:52:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:52:29 INFO - (blobuploader) - INFO - Done attempting. 19:52:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:52:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:52:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:52:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:52:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:52:32 INFO - (blobuploader) - INFO - Done attempting. 19:52:32 INFO - (blobuploader) - INFO - Iteration through files over. 19:52:32 INFO - Return code: 0 19:52:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:52:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:52:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfefce0bad63e0d9aec74d0a2bcf9c34b38d41d89ae3db58072fa4c5ac66b81c892a5fb6ad810a60f68e9133c86a404e34e852f74dd18a630e54eaf97502e67a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65b5c513484f9bf71f54c929792437fd8ddc15b85e23a6a747781341438ff748d7e2af8891d03f86898bb906e86f78d5cddd50fbc88269e4887585a54adb848", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81e5f1dda850813420d4b77642d02ebe2b91f6006b5dea23ccb4aa18bfd077dd97ae11d574ee2bb54ad8518a7a3421f444391115b625589e60cd4153bc5348f5"} 19:52:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:52:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:52:32 INFO - Contents: 19:52:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfefce0bad63e0d9aec74d0a2bcf9c34b38d41d89ae3db58072fa4c5ac66b81c892a5fb6ad810a60f68e9133c86a404e34e852f74dd18a630e54eaf97502e67a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65b5c513484f9bf71f54c929792437fd8ddc15b85e23a6a747781341438ff748d7e2af8891d03f86898bb906e86f78d5cddd50fbc88269e4887585a54adb848", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81e5f1dda850813420d4b77642d02ebe2b91f6006b5dea23ccb4aa18bfd077dd97ae11d574ee2bb54ad8518a7a3421f444391115b625589e60cd4153bc5348f5"} 19:52:32 INFO - Running post-run listener: copy_logs_to_upload_dir 19:52:32 INFO - Copying logs to upload dir... 19:52:32 INFO - mkdir: /builds/slave/test/build/upload/logs 19:52:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.481696 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-11-16 19:52:32.141826) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 19:52:32.145266) ========= 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.fcylvFtlDD/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.TCAdcGoR46/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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/Firefox/sha512/cfefce0bad63e0d9aec74d0a2bcf9c34b38d41d89ae3db58072fa4c5ac66b81c892a5fb6ad810a60f68e9133c86a404e34e852f74dd18a630e54eaf97502e67a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65b5c513484f9bf71f54c929792437fd8ddc15b85e23a6a747781341438ff748d7e2af8891d03f86898bb906e86f78d5cddd50fbc88269e4887585a54adb848", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81e5f1dda850813420d4b77642d02ebe2b91f6006b5dea23ccb4aa18bfd077dd97ae11d574ee2bb54ad8518a7a3421f444391115b625589e60cd4153bc5348f5"} build_url:https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010975 build_url: 'https://queue.taskcluster.net/v1/task/H4upJPcbQPaC9yql9gfyMw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfefce0bad63e0d9aec74d0a2bcf9c34b38d41d89ae3db58072fa4c5ac66b81c892a5fb6ad810a60f68e9133c86a404e34e852f74dd18a630e54eaf97502e67a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65b5c513484f9bf71f54c929792437fd8ddc15b85e23a6a747781341438ff748d7e2af8891d03f86898bb906e86f78d5cddd50fbc88269e4887585a54adb848", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81e5f1dda850813420d4b77642d02ebe2b91f6006b5dea23ccb4aa18bfd077dd97ae11d574ee2bb54ad8518a7a3421f444391115b625589e60cd4153bc5348f5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 19:52:32.177847) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:52:32.178222) ========= 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.fcylvFtlDD/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.TCAdcGoR46/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005208 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:52:32.226717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 19:52:32.227059) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 19:52:32.227417) ========= ========= Total master_lag: 0.18 =========