builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0282 starttime: 1487170214.71 results: success (0) buildid: 20170215045145 builduid: 595594ac17ac4a7ab5e70dddad7f5974 revision: 5e8f82a565cfe536feb9bb3a6b16395eaf14bf40 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 06:50:14.709121) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 06:50:14.709526) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 06:50:14.709816) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 06:50:14.738806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 06:50:14.739472) ========= 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.wSIINV1s3a/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.iVJbd66Qmz/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-15 06:50:14-- 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% 168M=0s 2017-02-15 06:50:14 (168 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.178751 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 06:50:14.948545) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 06:50:14.948857) ========= 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.wSIINV1s3a/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.iVJbd66Qmz/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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.023650 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 06:50:14.999434) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-15 06:50:14.999804) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e8f82a565cfe536feb9bb3a6b16395eaf14bf40 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e8f82a565cfe536feb9bb3a6b16395eaf14bf40 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wSIINV1s3a/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.iVJbd66Qmz/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-15 06:50:15,108 truncating revision to first 12 chars 2017-02-15 06:50:15,108 Setting DEBUG logging. 2017-02-15 06:50:15,108 attempt 1/10 2017-02-15 06:50:15,108 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5e8f82a565cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-15 06:50:16,414 unpacking tar archive at: mozilla-beta-5e8f82a565cf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.573636 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-15 06:50:16.597238) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 06:50:16.597554) ========= script_repo_revision: 5e8f82a565cfe536feb9bb3a6b16395eaf14bf40 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 06:50:16.597956) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 06:50:16.598216) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 06:50:16.617932) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-15 06:50:16.618305) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wSIINV1s3a/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.iVJbd66Qmz/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 06:50:16 INFO - MultiFileLogger online at 20170215 06:50:16 in /builds/slave/test 06:50:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:50:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:50:16 INFO - {'append_to_log': False, 06:50:16 INFO - 'base_work_dir': '/builds/slave/test', 06:50:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:50:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:50:16 INFO - 'branch': 'Mozilla-Beta', 06:50:16 INFO - 'buildbot_json_path': 'buildprops.json', 06:50:16 INFO - 'config_files': ('talos/mac_config.py',), 06:50:16 INFO - 'default_actions': ('clobber', 06:50:16 INFO - 'read-buildbot-config', 06:50:16 INFO - 'download-and-extract', 06:50:16 INFO - 'populate-webroot', 06:50:16 INFO - 'create-virtualenv', 06:50:16 INFO - 'install', 06:50:16 INFO - 'run-tests'), 06:50:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:50:16 INFO - 'download_minidump_stackwalk': True, 06:50:16 INFO - 'download_symbols': 'ondemand', 06:50:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:50:16 INFO - 'tooltool.py': '/tools/tooltool.py', 06:50:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:50:16 INFO - '/tools/misc-python/virtualenv.py')}, 06:50:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:50:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:50:16 INFO - 'installer_path': 'installer.exe', 06:50:16 INFO - 'log_level': 'info', 06:50:16 INFO - 'log_name': 'talos', 06:50:16 INFO - 'log_to_console': True, 06:50:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:50:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:50:16 INFO - 'opt_config_files': (), 06:50:16 INFO - 'pip_index': False, 06:50:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:50:16 INFO - 'cmd': ('bash', 06:50:16 INFO - '-c', 06:50:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:50:16 INFO - 'enabled': True, 06:50:16 INFO - 'halt_on_failure': False, 06:50:16 INFO - 'name': 'check_screen_resolution'},), 06:50:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:50:16 INFO - 'cmd': ('bash', 06:50:16 INFO - '-c', 06:50:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:50:16 INFO - 'enabled': True, 06:50:16 INFO - 'halt_on_failure': False, 06:50:16 INFO - 'name': 'check_screen_resolution'},), 06:50:16 INFO - 'run_cmd_checks_enabled': True, 06:50:16 INFO - 'sps_profile': False, 06:50:16 INFO - 'sps_profile_interval': 0, 06:50:16 INFO - 'suite': 'dromaeojs', 06:50:16 INFO - 'system_bits': '32', 06:50:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:50:16 INFO - 'title': 't-yosemite-r7-0282', 06:50:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:50:16 INFO - 'use_talos_json': True, 06:50:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:50:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:50:16 INFO - 'work_dir': 'build'} 06:50:16 INFO - [mozharness: 2017-02-15 14:50:16.832463Z] Running clobber step. 06:50:16 INFO - Running pre-action listener: _resource_record_pre_action 06:50:16 INFO - Running main action method: clobber 06:50:16 INFO - rmtree: /builds/slave/test/build 06:50:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:50:19 INFO - Running post-action listener: _resource_record_post_action 06:50:19 INFO - [mozharness: 2017-02-15 14:50:19.213226Z] Finished clobber step (success) 06:50:19 INFO - [mozharness: 2017-02-15 14:50:19.213389Z] Running read-buildbot-config step. 06:50:19 INFO - Running pre-action listener: _resource_record_pre_action 06:50:19 INFO - Running main action method: read_buildbot_config 06:50:19 INFO - Using buildbot properties: 06:50:19 INFO - { 06:50:19 INFO - "project": "", 06:50:19 INFO - "product": "firefox", 06:50:19 INFO - "script_repo_revision": "production", 06:50:19 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 06:50:19 INFO - "repository": "", 06:50:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 06:50:19 INFO - "buildid": "20170215045145", 06:50:19 INFO - "pgo_build": "False", 06:50:19 INFO - "basedir": "/builds/slave/test", 06:50:19 INFO - "buildnumber": 9, 06:50:19 INFO - "slavename": "t-yosemite-r7-0282", 06:50:19 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:50:19 INFO - "platform": "yosemite_r7", 06:50:19 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:50:19 INFO - "branch": "mozilla-beta", 06:50:19 INFO - "repo_path": "releases/mozilla-beta", 06:50:19 INFO - "revision": "5e8f82a565cfe536feb9bb3a6b16395eaf14bf40", 06:50:19 INFO - "stage_platform": "macosx64", 06:50:19 INFO - "builduid": "595594ac17ac4a7ab5e70dddad7f5974", 06:50:19 INFO - "slavebuilddir": "test" 06:50:19 INFO - } 06:50:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 06:50:19 INFO - Running post-action listener: _resource_record_post_action 06:50:19 INFO - [mozharness: 2017-02-15 14:50:19.217404Z] Finished read-buildbot-config step (success) 06:50:19 INFO - [mozharness: 2017-02-15 14:50:19.217519Z] Running download-and-extract step. 06:50:19 INFO - Running pre-action listener: _resource_record_pre_action 06:50:19 INFO - Running main action method: download_and_extract 06:50:19 INFO - mkdir: /builds/slave/test/build/tests 06:50:19 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')]} 06:50:19 INFO - trying https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 06:50:19 INFO - Downloading https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 06:50:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 06:50:19 INFO - Downloaded 1165 bytes. 06:50:19 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 06:50:19 INFO - Using the following test package requirements: 06:50:19 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 06:50:19 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:50:19 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 06:50:19 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:50:19 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 06:50:19 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:50:19 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:50:19 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 06:50:19 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 06:50:19 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:50:19 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 06:50:19 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:50:19 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 06:50:19 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:50:19 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 06:50:19 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:50:19 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 06:50:19 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 06:50:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 06:50:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 06:50:19 INFO - Fetch https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 06:50:20 INFO - Http code: 200 06:50:20 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 06:50:20 INFO - x-amz-cf-id: xO4TFsrm-RXw75JV3W482SBwDJOli2pL3deUp7_8hqKANPYlQqsWjw== 06:50:20 INFO - x-amz-version-id: qm52XtybBVOF.U2yDsONIlvZwv5qH2uW 06:50:20 INFO - Expected file size: 16094075 06:50:20 INFO - Obtained file size: 16094075 06:50:27 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 06:50:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 06:50:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 06:50:27 INFO - Fetch https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 06:50:28 INFO - Http code: 200 06:50:28 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 06:50:28 INFO - x-amz-cf-id: kRGw08VMY77zLL2MsKqqUuzAyP8xkRolir_tGyJCn21quMHqvWqB2Q== 06:50:28 INFO - x-amz-version-id: qm52XtybBVOF.U2yDsONIlvZwv5qH2uW 06:50:28 INFO - Expected file size: 16094075 06:50:28 INFO - Obtained file size: 16094075 06:50:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 06:50:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 06:50:34 INFO - Fetch https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 06:50:35 INFO - Http code: 200 06:50:35 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 06:50:35 INFO - x-amz-cf-id: MkpEf6E_FZ1x5Bv5VWMXVAjA5bs7Yn-q-8OeLn2WyyJYcF0D1pZdhQ== 06:50:35 INFO - x-amz-version-id: LnvDrLBkmPiBFy_SNlY_OY9u9BeaQvA9 06:50:36 INFO - Expected file size: 14403005 06:50:36 INFO - Obtained file size: 14403005 06:50:37 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')]} 06:50:37 INFO - trying https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg 06:50:37 INFO - Downloading https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 06:50:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 06:50:39 INFO - Downloaded 82111359 bytes. 06:50:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg 06:50:39 INFO - mkdir: /builds/slave/test/properties 06:50:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:50:39 INFO - Writing to file /builds/slave/test/properties/build_url 06:50:39 INFO - Contents: 06:50:39 INFO - build_url:https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg 06:50:39 INFO - Running post-action listener: _resource_record_post_action 06:50:39 INFO - Running post-action listener: set_extra_try_arguments 06:50:39 INFO - [mozharness: 2017-02-15 14:50:39.986739Z] Finished download-and-extract step (success) 06:50:39 INFO - [mozharness: 2017-02-15 14:50:39.986898Z] Running populate-webroot step. 06:50:39 INFO - Running pre-action listener: _resource_record_pre_action 06:50:39 INFO - Running main action method: populate_webroot 06:50:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:50:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:50:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:50:39 INFO - '--tppagecycles', 06:50:39 INFO - '7'], 06:50:39 INFO - 'tests': ['tsvgm']}}, 06:50:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:50:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:50:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:50:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:50:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:50:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:50:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:39 INFO - 'talos_options': ['--disable-e10s'], 06:50:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:39 INFO - 'talos_options': ['--disable-e10s'], 06:50:39 INFO - 'tests': ['damp', 'tps']}, 06:50:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:39 INFO - 'tests': ['damp', 'tps']}, 06:50:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:50:39 INFO - 'tests': ['dromaeo_dom']}, 06:50:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:50:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:50:39 INFO - 'tests': ['basic_compositor_video']}, 06:50:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:50:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:50:39 INFO - 'tests': ['a11yr', 06:50:39 INFO - 'ts_paint', 06:50:39 INFO - 'tpaint', 06:50:39 INFO - 'sessionrestore', 06:50:39 INFO - 'sessionrestore_no_auto_restore', 06:50:39 INFO - 'tabpaint']}, 06:50:39 INFO - 'other-e10s': {'tests': ['a11yr', 06:50:39 INFO - 'ts_paint', 06:50:39 INFO - 'tpaint', 06:50:39 INFO - 'sessionrestore', 06:50:39 INFO - 'sessionrestore_no_auto_restore', 06:50:39 INFO - 'tabpaint']}, 06:50:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:50:40 INFO - 'ts_paint', 06:50:40 INFO - 'tpaint', 06:50:40 INFO - 'sessionrestore', 06:50:40 INFO - 'sessionrestore_no_auto_restore', 06:50:40 INFO - 'tabpaint']}, 06:50:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:50:40 INFO - 'ts_paint', 06:50:40 INFO - 'tpaint', 06:50:40 INFO - 'sessionrestore', 06:50:40 INFO - 'sessionrestore_no_auto_restore', 06:50:40 INFO - 'tabpaint']}, 06:50:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:50:40 INFO - 'tests': ['a11yr', 06:50:40 INFO - 'ts_paint', 06:50:40 INFO - 'tpaint', 06:50:40 INFO - 'sessionrestore', 06:50:40 INFO - 'sessionrestore_no_auto_restore', 06:50:40 INFO - 'tabpaint']}, 06:50:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:50:40 INFO - 'tests': ['a11yr', 06:50:40 INFO - 'ts_paint', 06:50:40 INFO - 'tpaint', 06:50:40 INFO - 'sessionrestore', 06:50:40 INFO - 'sessionrestore_no_auto_restore', 06:50:40 INFO - 'tabpaint']}, 06:50:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:50:40 INFO - 'tests': ['tsvgx', 06:50:40 INFO - 'tsvgr_opacity', 06:50:40 INFO - 'tart', 06:50:40 INFO - 'tscrollx', 06:50:40 INFO - 'cart']}, 06:50:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:50:40 INFO - 'tsvgr_opacity', 06:50:40 INFO - 'tart', 06:50:40 INFO - 'tscrollx', 06:50:40 INFO - 'cart']}, 06:50:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:40 INFO - 'talos_options': ['--disable-e10s'], 06:50:40 INFO - 'tests': ['tp5o']}, 06:50:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:40 INFO - 'tests': ['tp5o']}, 06:50:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:40 INFO - 'talos_options': ['--disable-e10s', 06:50:40 INFO - '--xperf_path', 06:50:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:40 INFO - 'tests': ['tp5n']}, 06:50:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:40 INFO - 'talos_options': ['--xperf_path', 06:50:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:40 INFO - 'tests': ['tp5n']}}, 06:50:40 INFO - 'talos.zip': {'path': '', 06:50:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:50:40 INFO - Running post-action listener: _resource_record_post_action 06:50:40 INFO - [mozharness: 2017-02-15 14:50:40.005444Z] Finished populate-webroot step (success) 06:50:40 INFO - [mozharness: 2017-02-15 14:50:40.005555Z] Running create-virtualenv step. 06:50:40 INFO - Running pre-action listener: _resource_record_pre_action 06:50:40 INFO - Running main action method: create_virtualenv 06:50:40 INFO - Creating virtualenv /builds/slave/test/build/venv 06:50: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 06:50:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:50:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:50:40 INFO - Using real prefix '/tools/python27' 06:50:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:50:40 INFO - Installing distribute.............................................................................................................................................................................................done. 06:50:43 INFO - Installing pip.................done. 06:50:43 INFO - Return code: 0 06:50:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:50:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:50:43 INFO - Reading from file tmpfile_stdout 06:50:43 INFO - Output received: 06:50:43 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) 06:50:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:43 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 0x10e8d2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff760565a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e6d30>, '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 0x10e54cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6deb20>, '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.wSIINV1s3a/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.iVJbd66Qmz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 06:50:43 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 06:50:43 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 06:50:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wSIINV1s3a/Render', 06:50:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:43 INFO - 'HOME': '/Users/cltbld', 06:50:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:43 INFO - 'LOGNAME': 'cltbld', 06:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:43 INFO - 'MOZ_NO_REMOTE': '1', 06:50:43 INFO - 'NO_EM_RESTART': '1', 06:50:43 INFO - 'PAGER': '/bin/cat', 06:50:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:43 INFO - 'PWD': '/builds/slave/test', 06:50:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:43 INFO - 'SHELL': '/bin/bash', 06:50:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iVJbd66Qmz/Listeners', 06:50:43 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 06:50:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:43 INFO - 'USER': 'cltbld', 06:50:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:43 INFO - 'XPC_FLAGS': '0x0', 06:50:43 INFO - 'XPC_SERVICE_NAME': '0', 06:50:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50: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 06:50:44 INFO - Cleaning up... 06:50:44 INFO - Return code: 0 06:50:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:50: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')]} 06:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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 0x10e8d2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff760565a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e6d30>, '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 0x10e54cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6deb20>, '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.wSIINV1s3a/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.iVJbd66Qmz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 06:50: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 06:50: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 06:50:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wSIINV1s3a/Render', 06:50:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:44 INFO - 'HOME': '/Users/cltbld', 06:50:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:44 INFO - 'LOGNAME': 'cltbld', 06:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:44 INFO - 'MOZ_NO_REMOTE': '1', 06:50:44 INFO - 'NO_EM_RESTART': '1', 06:50:44 INFO - 'PAGER': '/bin/cat', 06:50:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:44 INFO - 'PWD': '/builds/slave/test', 06:50:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:44 INFO - 'SHELL': '/bin/bash', 06:50:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iVJbd66Qmz/Listeners', 06:50:44 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 06:50:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:44 INFO - 'USER': 'cltbld', 06:50:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:44 INFO - 'XPC_FLAGS': '0x0', 06:50:44 INFO - 'XPC_SERVICE_NAME': '0', 06:50:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:44 INFO - Downloading/unpacking psutil>=3.1.1 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:50:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:47 INFO - Installing collected packages: psutil 06:50:47 INFO - Running setup.py install for psutil 06:50:48 INFO - building 'psutil._psutil_osx' extension 06:50: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 06:50: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 06:50: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:50:48 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 06:50:48 INFO - building 'psutil._psutil_posix' extension 06:50:48 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 06:50:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:50:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:50:48 INFO - ^ 06:50:48 INFO - 1 warning generated. 06:50:48 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 06:50:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:49 INFO - Successfully installed psutil 06:50:49 INFO - Cleaning up... 06:50:49 INFO - Return code: 0 06:50:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:50: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')]} 06:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:50 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 0x10e8d2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff760565a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e6d30>, '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 0x10e54cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6deb20>, '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.wSIINV1s3a/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.iVJbd66Qmz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 06:50:50 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 06:50:50 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 06:50:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wSIINV1s3a/Render', 06:50:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:50 INFO - 'HOME': '/Users/cltbld', 06:50:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:50 INFO - 'LOGNAME': 'cltbld', 06:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:50 INFO - 'MOZ_NO_REMOTE': '1', 06:50:50 INFO - 'NO_EM_RESTART': '1', 06:50:50 INFO - 'PAGER': '/bin/cat', 06:50:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:50 INFO - 'PWD': '/builds/slave/test', 06:50:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:50 INFO - 'SHELL': '/bin/bash', 06:50:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iVJbd66Qmz/Listeners', 06:50:50 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 06:50:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:50 INFO - 'USER': 'cltbld', 06:50:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:50 INFO - 'XPC_FLAGS': '0x0', 06:50:50 INFO - 'XPC_SERVICE_NAME': '0', 06:50:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:50:52 INFO - Installing collected packages: mozsystemmonitor 06:50:52 INFO - Running setup.py install for mozsystemmonitor 06:50:53 INFO - Successfully installed mozsystemmonitor 06:50:53 INFO - Cleaning up... 06:50:53 INFO - Return code: 0 06:50:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e8d2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff760565a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e6d30>, '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 0x10e54cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6deb20>, '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.wSIINV1s3a/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.iVJbd66Qmz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 06:50:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:50:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wSIINV1s3a/Render', 06:50:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:53 INFO - 'HOME': '/Users/cltbld', 06:50:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:53 INFO - 'LOGNAME': 'cltbld', 06:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:53 INFO - 'MOZ_NO_REMOTE': '1', 06:50:53 INFO - 'NO_EM_RESTART': '1', 06:50:53 INFO - 'PAGER': '/bin/cat', 06:50:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:53 INFO - 'PWD': '/builds/slave/test', 06:50:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:53 INFO - 'SHELL': '/bin/bash', 06:50:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iVJbd66Qmz/Listeners', 06:50:53 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 06:50:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:53 INFO - 'USER': 'cltbld', 06:50:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:53 INFO - 'XPC_FLAGS': '0x0', 06:50:53 INFO - 'XPC_SERVICE_NAME': '0', 06:50:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:53 INFO - Downloading/unpacking jsonschema==2.5.1 06:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:50:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:56 INFO - Downloading functools32-3.2.3-2.tar.gz 06:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:50:56 INFO - warning: no files found matching '*.txt' 06:50:56 INFO - no previously-included directories found matching 'build' 06:50:56 INFO - no previously-included directories found matching 'dist' 06:50:56 INFO - no previously-included directories found matching '.git*' 06:50:56 INFO - Installing collected packages: jsonschema, functools32 06:50:56 INFO - Running setup.py install for functools32 06:50:56 INFO - warning: no files found matching '*.txt' 06:50:56 INFO - no previously-included directories found matching 'build' 06:50:56 INFO - no previously-included directories found matching 'dist' 06:50:56 INFO - no previously-included directories found matching '.git*' 06:50:56 INFO - Successfully installed jsonschema functools32 06:50:56 INFO - Cleaning up... 06:50:56 INFO - Return code: 0 06:50:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:50: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')]} 06:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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 0x10e8d2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff760565a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e6d30>, '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 0x10e54cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6deb20>, '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.wSIINV1s3a/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.iVJbd66Qmz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 06:50: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 06:50: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 06:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wSIINV1s3a/Render', 06:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:56 INFO - 'HOME': '/Users/cltbld', 06:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:56 INFO - 'LOGNAME': 'cltbld', 06:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:56 INFO - 'MOZ_NO_REMOTE': '1', 06:50:56 INFO - 'NO_EM_RESTART': '1', 06:50:56 INFO - 'PAGER': '/bin/cat', 06:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:56 INFO - 'PWD': '/builds/slave/test', 06:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:56 INFO - 'SHELL': '/bin/bash', 06:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iVJbd66Qmz/Listeners', 06:50:56 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 06:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:56 INFO - 'USER': 'cltbld', 06:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:56 INFO - 'XPC_FLAGS': '0x0', 06:50:56 INFO - 'XPC_SERVICE_NAME': '0', 06:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:50:57 INFO - Cleaning up... 06:50:57 INFO - Return code: 0 06:50:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:57 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 0x10e8d2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff760565a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e6d30>, '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 0x10e54cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6deb20>, '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.wSIINV1s3a/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.iVJbd66Qmz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 06:50:57 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 06:50:57 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 06:50:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wSIINV1s3a/Render', 06:50:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:57 INFO - 'HOME': '/Users/cltbld', 06:50:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:57 INFO - 'LOGNAME': 'cltbld', 06:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:57 INFO - 'MOZ_NO_REMOTE': '1', 06:50:57 INFO - 'NO_EM_RESTART': '1', 06:50:57 INFO - 'PAGER': '/bin/cat', 06:50:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:57 INFO - 'PWD': '/builds/slave/test', 06:50:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:57 INFO - 'SHELL': '/bin/bash', 06:50:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iVJbd66Qmz/Listeners', 06:50:57 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 06:50:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:57 INFO - 'USER': 'cltbld', 06:50:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:57 INFO - 'XPC_FLAGS': '0x0', 06:50:57 INFO - 'XPC_SERVICE_NAME': '0', 06:50:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:57 INFO - Downloading/unpacking blobuploader==1.2.4 06:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:59 INFO - Downloading blobuploader-1.2.4.tar.gz 06:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:50:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:51:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:51:00 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 06:51:00 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 06:51:00 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 06:51:00 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 06:51:00 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 06:51:00 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 06:51:01 INFO - Downloading docopt-0.6.1.tar.gz 06:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:51:01 INFO - Installing collected packages: blobuploader, requests, docopt 06:51:01 INFO - Running setup.py install for blobuploader 06:51:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:51:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:51:01 INFO - Running setup.py install for requests 06:51:01 INFO - Running setup.py install for docopt 06:51:01 INFO - Successfully installed blobuploader requests docopt 06:51:01 INFO - Cleaning up... 06:51:02 INFO - Return code: 0 06:51:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:02 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')]} 06:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:02 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')]} 06:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:02 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 0x10e8d2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff760565a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e6d30>, '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 0x10e54cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6deb20>, '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.wSIINV1s3a/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.iVJbd66Qmz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 06:51:02 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 06:51:02 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 06:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wSIINV1s3a/Render', 06:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:02 INFO - 'HOME': '/Users/cltbld', 06:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:02 INFO - 'LOGNAME': 'cltbld', 06:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:02 INFO - 'MOZ_NO_REMOTE': '1', 06:51:02 INFO - 'NO_EM_RESTART': '1', 06:51:02 INFO - 'PAGER': '/bin/cat', 06:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:02 INFO - 'PWD': '/builds/slave/test', 06:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:02 INFO - 'SHELL': '/bin/bash', 06:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iVJbd66Qmz/Listeners', 06:51:02 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 06:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:02 INFO - 'USER': 'cltbld', 06:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:02 INFO - 'XPC_FLAGS': '0x0', 06:51:02 INFO - 'XPC_SERVICE_NAME': '0', 06:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:02 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-oug_uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:02 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-d8WPuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:02 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-RdwEry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:02 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-CfcYfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:02 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-7F0qpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:02 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-43FQ1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:02 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-KpWR1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-xwFCAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-1vz1E_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-JJbQsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-Ofp3hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-Yhe0A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-OpMcyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-UIxUPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-OnBtZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-Qv_qAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:04 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-hjvfWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:51:04 INFO - Running setup.py install for manifestparser 06:51:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:51:04 INFO - Running setup.py install for mozcrash 06:51:04 INFO - Running setup.py install for mozdebug 06:51:04 INFO - Running setup.py install for mozdevice 06:51:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:51:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:51:04 INFO - Running setup.py install for mozfile 06:51:04 INFO - Running setup.py install for mozhttpd 06:51:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:51:05 INFO - Running setup.py install for mozinfo 06:51:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:51:05 INFO - Running setup.py install for mozInstall 06:51:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:51:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:51:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:51:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:51:05 INFO - Running setup.py install for mozleak 06:51:05 INFO - Running setup.py install for mozlog 06:51:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:51:05 INFO - Running setup.py install for moznetwork 06:51:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:51:05 INFO - Running setup.py install for mozprocess 06:51:05 INFO - Running setup.py install for mozprofile 06:51:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:51:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:51:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:51:06 INFO - Running setup.py install for mozrunner 06:51:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:51:06 INFO - Running setup.py install for mozscreenshot 06:51:06 INFO - Running setup.py install for moztest 06:51:06 INFO - Running setup.py install for mozversion 06:51:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:51:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:51:06 INFO - Cleaning up... 06:51:06 INFO - Return code: 0 06:51:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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 0x10e8d2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff760565a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e6d30>, '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 0x10e54cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6deb20>, '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.wSIINV1s3a/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.iVJbd66Qmz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 06:51: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 06:51: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 06:51:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wSIINV1s3a/Render', 06:51:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:06 INFO - 'HOME': '/Users/cltbld', 06:51:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:06 INFO - 'LOGNAME': 'cltbld', 06:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:06 INFO - 'MOZ_NO_REMOTE': '1', 06:51:06 INFO - 'NO_EM_RESTART': '1', 06:51:06 INFO - 'PAGER': '/bin/cat', 06:51:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:06 INFO - 'PWD': '/builds/slave/test', 06:51:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:06 INFO - 'SHELL': '/bin/bash', 06:51:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iVJbd66Qmz/Listeners', 06:51:06 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 06:51:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:06 INFO - 'USER': 'cltbld', 06:51:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:06 INFO - 'XPC_FLAGS': '0x0', 06:51:06 INFO - 'XPC_SERVICE_NAME': '0', 06:51:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:07 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-Vhg8fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51: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)) 06:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:07 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-PnQQTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51: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)) 06:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:07 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-oOzTOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51: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)) 06:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:07 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-bObd0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51: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)) 06:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:07 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-VabX3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51: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)) 06:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:07 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-pkUGD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51: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)) 06:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:07 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-6khYDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51: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)) 06:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:07 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-yHWehR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51: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)) 06:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:07 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-q3KaZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51: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)) 06:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:07 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-dXm5Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51: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)) 06:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:08 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-7r53Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51: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)) 06:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:08 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-vffAdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51: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)) 06:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:08 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-SqmPea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51: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)) 06:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:08 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-qnApLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51: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)) 06:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:08 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-CTw7no-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51: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)) 06:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:08 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-gyJuHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:08 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-0bv7Th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51: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)) 06:51: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)) 06:51: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)) 06:51: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)) 06:51: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)) 06:51: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)) 06:51:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51:11 INFO - Downloading blessings-1.6.tar.gz 06:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:51:11 INFO - Installing collected packages: blessings 06:51:11 INFO - Running setup.py install for blessings 06:51:11 INFO - Successfully installed blessings 06:51:11 INFO - Cleaning up... 06:51:11 INFO - Return code: 0 06:51:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:51:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:12 INFO - Reading from file tmpfile_stdout 06:51:12 INFO - Current package versions: 06:51:12 INFO - blessings == 1.6 06:51:12 INFO - blobuploader == 1.2.4 06:51:12 INFO - docopt == 0.6.1 06:51:12 INFO - functools32 == 3.2.3-2 06:51:12 INFO - jsonschema == 2.5.1 06:51:12 INFO - manifestparser == 1.1 06:51:12 INFO - mozInstall == 1.12 06:51:12 INFO - mozcrash == 1.0 06:51:12 INFO - mozdebug == 0.1 06:51:12 INFO - mozdevice == 0.48 06:51:12 INFO - mozfile == 1.2 06:51:12 INFO - mozhttpd == 0.7 06:51:12 INFO - mozinfo == 0.9 06:51:12 INFO - mozleak == 0.1 06:51:12 INFO - mozlog == 3.4 06:51:12 INFO - moznetwork == 0.27 06:51:12 INFO - mozprocess == 0.23 06:51:12 INFO - mozprofile == 0.28 06:51:12 INFO - mozrunner == 6.13 06:51:12 INFO - mozscreenshot == 0.1 06:51:12 INFO - mozsystemmonitor == 0.3 06:51:12 INFO - moztest == 0.8 06:51:12 INFO - mozversion == 1.4 06:51:12 INFO - psutil == 3.1.1 06:51:12 INFO - requests == 1.2.3 06:51:12 INFO - wsgiref == 0.1.2 06:51:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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 0x10e8d2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff760565a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e6d30>, '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 0x10e54cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6deb20>, '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.wSIINV1s3a/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.iVJbd66Qmz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 06:51: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 06:51: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 06:51:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wSIINV1s3a/Render', 06:51:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:12 INFO - 'HOME': '/Users/cltbld', 06:51:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:12 INFO - 'LOGNAME': 'cltbld', 06:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:12 INFO - 'MOZ_NO_REMOTE': '1', 06:51:12 INFO - 'NO_EM_RESTART': '1', 06:51:12 INFO - 'PAGER': '/bin/cat', 06:51:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:12 INFO - 'PWD': '/builds/slave/test', 06:51:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:12 INFO - 'SHELL': '/bin/bash', 06:51:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iVJbd66Qmz/Listeners', 06:51:12 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 06:51:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:12 INFO - 'USER': 'cltbld', 06:51:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:12 INFO - 'XPC_FLAGS': '0x0', 06:51:12 INFO - 'XPC_SERVICE_NAME': '0', 06:51:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51: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)) 06:51: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)) 06:51: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)) 06:51: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)) 06:51: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)) 06:51: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)) 06:51: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)) 06:51: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)) 06:51: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)) 06:51: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)) 06:51: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)) 06:51:12 INFO - Cleaning up... 06:51:12 INFO - Return code: 0 06:51:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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 0x10e8d2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff760565a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e6d30>, '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 0x10e54cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6deb20>, '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.wSIINV1s3a/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.iVJbd66Qmz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 06:51: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 06:51: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 06:51:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wSIINV1s3a/Render', 06:51:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:12 INFO - 'HOME': '/Users/cltbld', 06:51:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:12 INFO - 'LOGNAME': 'cltbld', 06:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:12 INFO - 'MOZ_NO_REMOTE': '1', 06:51:12 INFO - 'NO_EM_RESTART': '1', 06:51:12 INFO - 'PAGER': '/bin/cat', 06:51:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:12 INFO - 'PWD': '/builds/slave/test', 06:51:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:12 INFO - 'SHELL': '/bin/bash', 06:51:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iVJbd66Qmz/Listeners', 06:51:12 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 06:51:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:12 INFO - 'USER': 'cltbld', 06:51:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:12 INFO - 'XPC_FLAGS': '0x0', 06:51:12 INFO - 'XPC_SERVICE_NAME': '0', 06:51:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:51:12 INFO - Cleaning up... 06:51:12 INFO - Return code: 0 06:51:12 INFO - Running post-action listener: _resource_record_post_action 06:51:12 INFO - Running post-action listener: _start_resource_monitoring 06:51:12 INFO - Starting resource monitoring. 06:51:12 INFO - [mozharness: 2017-02-15 14:51:12.571159Z] Finished create-virtualenv step (success) 06:51:12 INFO - [mozharness: 2017-02-15 14:51:12.572133Z] Running install step. 06:51:12 INFO - Running pre-action listener: _resource_record_pre_action 06:51:12 INFO - Running main action method: install 06:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:12 INFO - Reading from file tmpfile_stdout 06:51:12 INFO - Detecting whether we're running mozinstall >=1.0... 06:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:51:12 INFO - Reading from file tmpfile_stdout 06:51:12 INFO - Output received: 06:51:12 INFO - Usage: mozinstall [options] installer 06:51:12 INFO - Options: 06:51:12 INFO - -h, --help show this help message and exit 06:51:12 INFO - -d DEST, --destination=DEST 06:51:12 INFO - Directory to install application into. [default: 06:51:12 INFO - "/builds/slave/test"] 06:51:12 INFO - --app=APP Application being installed. [default: firefox] 06:51:12 INFO - mkdir: /builds/slave/test/build/application 06:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 06:51:34 INFO - Reading from file tmpfile_stdout 06:51:34 INFO - Output received: 06:51:34 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:51:34 INFO - Running post-action listener: _resource_record_post_action 06:51:34 INFO - [mozharness: 2017-02-15 14:51:34.500111Z] Finished install step (success) 06:51:34 INFO - [mozharness: 2017-02-15 14:51:34.500284Z] Running run-tests step. 06:51:34 INFO - Running pre-action listener: _resource_record_pre_action 06:51:34 INFO - Running main action method: run_tests 06:51:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:51:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:51:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:51:34 INFO - 2017-02-15 06:51:34.514 screenresolution[1630:8157] starting screenresolution argv=screenresolution get 06:51:34 INFO - 2017-02-15 06:51:34.517 screenresolution[1630:8157] Display 0: 1600x1200x32@60 06:51:34 INFO - 2017-02-15 06:51:34.523 screenresolution[1631:8159] starting screenresolution argv=screenresolution list 06:51:34 INFO - Available Modes on Display 0 06:51:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:51:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:51:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:51:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:51:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:51:34 INFO - Intel Iris: 06:51:34 INFO - Chipset Model: Intel Iris 06:51:34 INFO - Type: GPU 06:51:34 INFO - Bus: Built-In 06:51:34 INFO - VRAM (Dynamic, Max): 1536 MB 06:51:34 INFO - Vendor: Intel (0x8086) 06:51:34 INFO - Device ID: 0x0a2e 06:51:34 INFO - Revision ID: 0x0009 06:51:34 INFO - Displays: 06:51:34 INFO - Display: 06:51:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:51:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:51:34 INFO - Display Serial Number: 1600x1200 60 06:51:34 INFO - Main Display: Yes 06:51:34 INFO - Mirror: Off 06:51:34 INFO - Online: Yes 06:51:34 INFO - Rotation: Supported 06:51:34 INFO - Return code: 0 06:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:51:34 INFO - Python 2.7.3 06:51:34 INFO - Return code: 0 06:51:34 INFO - grabbing minidump binary from tooltool 06:51:34 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')]} 06:51:34 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 0x10e6e6d30>, '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 0x10e54cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6deb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:51:34 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 06:51:34 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 06:51:34 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 06:51:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:51:34 INFO - Return code: 0 06:51:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:51:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:51:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:51:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:51:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0282', '--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 06:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0282 --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 06:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wSIINV1s3a/Render', 06:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:34 INFO - 'HOME': '/Users/cltbld', 06:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:34 INFO - 'LOGNAME': 'cltbld', 06:51:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:51:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:34 INFO - 'MOZ_NO_REMOTE': '1', 06:51:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:51:34 INFO - 'NO_EM_RESTART': '1', 06:51:34 INFO - 'PAGER': '/bin/cat', 06:51:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:34 INFO - 'PWD': '/builds/slave/test', 06:51:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:34 INFO - 'SHELL': '/bin/bash', 06:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iVJbd66Qmz/Listeners', 06:51:34 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 06:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:34 INFO - 'USER': 'cltbld', 06:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:34 INFO - 'XPC_FLAGS': '0x0', 06:51:34 INFO - 'XPC_SERVICE_NAME': '0', 06:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0282', '--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 06:51:35 INFO - mozversion application_buildid: 20170215045145 06:51:35 INFO - mozversion application_changeset: 5e8f82a565cfe536feb9bb3a6b16395eaf14bf40 06:51:35 INFO - mozversion application_display_name: Firefox 06:51:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:51:35 INFO - mozversion application_name: Firefox 06:51:35 INFO - mozversion application_remotingname: firefox 06:51:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:51:35 INFO - mozversion application_vendor: Mozilla 06:51:35 INFO - mozversion application_version: 52.0 06:51:35 INFO - mozversion platform_buildid: 20170215045145 06:51:35 INFO - mozversion platform_changeset: 5e8f82a565cfe536feb9bb3a6b16395eaf14bf40 06:51:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:51:35 INFO - mozversion platform_version: 52.0 06:51:35 INFO - using testdate: 1487170295 06:51:35 INFO - actual date: 1487170295 06:51:35 INFO - starting webserver on 'localhost:49241' 06:51:35 INFO - SUITE-START | Running 2 tests 06:51:35 INFO - TEST-START | dromaeo_css 06:51:35 INFO - operating with platform_type : mac_ 06:51:35 INFO - Initialising browser for dromaeo_css test... 06:51:35 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmpEA5PXi/profile http://localhost:49241/getInfo.html) 06:51:37 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 06:51:37 INFO - PROCESS | 1641 | colorDepth:24 06:51:37 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 06:51:37 INFO - PROCESS | 1641 | __metrics 06:51:37 INFO - PROCESS | 1641 | 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" 06:51:37 INFO - PROCESS | 1641 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:51:38 INFO - TEST-INFO | 1641: exit 0 06:51:38 INFO - Browser initialized. 06:51:38 INFO - Running cycle 1/1 for dromaeo_css test... 06:51:38 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmpEA5PXi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:51:50 INFO - PROCESS | 1645 | RSS: Main: 167473152 06:51:50 INFO - PROCESS | 1645 | 06:54:54 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 06:54:55 INFO - PROCESS | 1645 | RSS: Main: 284053504 06:54:55 INFO - PROCESS | 1645 | 06:57:58 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 06:57:59 INFO - PROCESS | 1645 | RSS: Main: 298831872 06:57:59 INFO - PROCESS | 1645 | 07:01:01 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 07:01:02 INFO - PROCESS | 1645 | RSS: Main: 294252544 07:01:02 INFO - PROCESS | 1645 | 07:04:04 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 07:04:04 INFO - PROCESS | 1645 | RSS: Main: 274845696 07:04:04 INFO - PROCESS | 1645 | 07:07:08 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 07:07:08 INFO - PROCESS | 1645 | RSS: Main: 265105408 07:07:08 INFO - PROCESS | 1645 | 07:10:11 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 07:10:12 INFO - PROCESS | 1645 | RSS: Main: 323129344 07:10:12 INFO - PROCESS | 1645 | 07:10:12 INFO - PROCESS | 1645 | __start_tp_report 07:10:12 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 07:10:12 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 07:10:12 INFO - PROCESS | 1645 | |i|pagename|runs| 07:10:12 INFO - PROCESS | 1645 | |0;dojo.html;3440.260344026034;3469.861205551778;3501.5973163086237;3512.6838584527386;3547.982260088699;5826.883462330751;5871.70641467927;5885.617434866731;5899.498542623872;5925.259342582177;5867.647941123525;5937.554683398752;5951.345352011286;5963.850903727409;5972.313183983843;5307.150855863053;5354.27717258169;5374;5426.240326354294;5449.291592093023;5258.368995720519;5310.256564081032;5312.867178320535;5431.103867861798;5456.781728730866;5334.439883812202;5409.891802163955;5410.702411367373;5411.83764487066;5412.702301373423;5329.973350133263;5343.091674415358;5377.596680248997;5404.540614047791;5410.783568657249;5180.860210753628;5240.580753539746;5346.27825243591;5370.221317908881;5387.488188622075;4905.337779399771;5735.340435849847;5777.133429985493;5777.306723193202;5949.91075133869;6171.59884607499;6200.255969283715;6212.502999760009;6214.65819379934;6228.657423841687;6233.158523599347;6236.781712640036;6245.62526248422;6246.375362463763;6251.812445626639;5707.4577915098;5738.1679656450415;5838.241028666246;5969.761209551612;5975.43233392827;6221.129041934133;6273.8745225095245;6288.9056664150075;6301.212348456443;6308.589941653778;6238.812835614939;6241.34465881085;6264.310925798159;6267.6866156691985;6270.498360131179;6167.599106058092;6226.501879849601;6230.158928544589;6232.439080482688;6247.375262473716;6158.291796443466;6171.506279497629;6211.472024877846;6232.719527621268;6252.562320637603;6213.254409470802;6213.5339849510565;6220.688965551704;6237.157983672146;6244.438000579969;4990.6257030722845;5038.2190760432195;5046.34397528319;5047.2429135629945;5064.392272927273;4462.843800466968;4489.304157855538;4525.117602067565;4542.931856022163;4561.840335588238;5739.311282646109;5811.564132690065;5818.592698511148;5867.002609556385;5917.201177841022;6196.504279657706;6204.627722336674;6212.844678882973;6214.844628884223;6216.627002379872;5503.532199763065;5799.536037117021;5812.360640329561;5873.030949893306;5894.528437725057;5290.65610735301;5345.572354211654;5353.197020446964;5353.732313384316;5355.009323275207;6199;6217.316095229431;6218.595791273553;6230.345813689588;6239.625622462667;6191.690415479118;6214.316425193316;6239.1577137087725;6243.282022567281;6262.780802671885;5255.448177941414;6195.845103872259;6319.304876463677;6357.936420635734;6362.45919096882;6131.540134489842;6155.384461553809;6262.123302737529;6266.279377871603;6306.495480361468;6156.1381406604005;6210.5031597473;6220.284667263141;6224.06639004153;6240.313565507699;5048;6239.407256310643;6246.281677607133;6265.498760099273;6271.749130034747;6229.972054610938;6256;6261.906071409024;6275.246970363585;6289.622622642656;5947.791827286197;6016.669083200466;6051.0923361496125;6063.120847477179;6097.146399503984;6230.7507699693315;6243.188385509855;6245.375462453719;6273.247210334789;6274.46667033289;5955.464008239279;6004.219451471281;6120.60216085953;6121.724522396414;6124.448799608057 07:10:12 INFO - PROCESS | 1645 | |1;ext.html;486.97565121743907;512.6795752654591;527.9815206467774;546.295279089974;561.4722161168502;29242.122736317917;31514.369712605763;39860.80069599651;40774.98062548438;40837.979050523754;41737.58262417375;42127.157456850924;42138.36792448116;42171.156576868445;42247.366289505604;9456.338056336042;9628.422294662343;9630.3258771886;9631.759206019835;9633.325667203299;9399.671011514598;9461.195798357114;9477.14705676489;9491.52542372882;9504.192143667762;9430.198433133157;9474.905250947471;9486.814148231471;9488.146066853982;9489.335746497747;9445.244380449547;9470.952645236799;9480.668176613786;9483.383580067342;9508.809823803555;9425.245980321557;9509.476978766164;9512.667056653054;9527.571259293349;9547.379420337656;39905.60094399077;40022.799886000386;40131;40147;40185;3024.8807941061727;3442.3115376924466;3508.6491350864962;3520.1903562180587;3716.3155926710706;28460.573091403647;29197;30071.398572028436;31257.843710781526;31496.685033149603;3286.079897628668;3309.321589074258;3381.2223188666744;3399.847006884696;3407.369636617234;483859.1614083849;488825;489535;490794.54602727114;492521;33591.99224023283;56036.15945760817;56372;56408.43591564114;56588.43411565832;33989.32021359559;34055.489167662505;34283.314333713184;34311.82844085764;34351.484727729105;14579.781303280459;14732;14744.262786860614;14750.926245368704;14765.261736913111;12316;12415.503379864886;12420.689482763004;12427.627171184879;12435.689107772198;7858.1356050834365;7876.803079923047;7898.684052637945;7954.443188976716;7965.243301886311;3300.66993300668;3309.1561651778643;3309.5532103166247;3312.966870331314;3333.81664008477;826.8594338962391;965.2663975378622;980.1423754215061;1122.4892673833385;1153.1581945180067;29004.854975724986;29229.26926826804;29495;29688.40623187524;29725.55411668827;1016.7051555049101;1018.2668478695327;1022.4529876516028;1047.7485403503103;1203.7712834561405;14871.628209294855;15272.770908436383;15291.388344466319;15611.985220960602;15645.374185032699;671331;715812;723732.3813380899;727518;962005;57276;58129.128063079086;58225.70887145537;58296.417035829945;58361.08194590254;1250.349818094604;1268.4482250221183;1288.0661520397637;1350.0279798545032;1355.0785465883098;23899.163529276393;30151.246218844706;30637.693623063486;31342.216444589067;32066.35867282688;54820.903581928935;55501.7224913889;55609.72195138998;55624;55788.163177551556;605860;611729;611739;613062;613412;31329.903453379935;33510.16224594405;34136.14659633529;41683.7915810419;42330.36504452374;44151.33772993343;45218.32172517349;45358.31962520499;46364.536354636024;46701.53298467108;31166;37645.870623881325;38347.616523834404;38352.285473571;38604.420933685455;37543;37674.246515070095;37771.05572360713;38576.614233858425;38643.227135456575;29891.95378161754;29983.950561731108;32132;36657.45013824848;37758.86723398302;30618;34041;34070.97787066392;34091.65908340984;34219.4867076999;24686.629700554866;24995.500089997735;25036.74963250344;25489.745102548735;25555 07:10:12 INFO - PROCESS | 1645 | |2;jquery.html;376.8323096222181;379.62227583554363;390.33253137135495;399.72019586289605;401.69671897717217;16375.83624163758;18213.08934553272;20166.6974995375;20359.898200509015;20376.98115094245;18664.72002919954;19136.617267654674;19603.21587136513;19630.41108766736;19732.408027759153;4689.39037925071;5706;5964.642121472704;5965.85085372867;5986.461218490335;4274.081072569397;4510.391097201868;4515.7516336601475;5832.650040997532;5930.347661757203;6219.502439804827;6491.513136514756;6535.509836762262;6554.737810487575;6585.539012269143;6368.745250189987;6460.515461340395;6479.902801457982;6526.608403495806;6536.248331441898;5036.345275114211;5696.23100881384;5705.572082093818;5708.457696518865;5730.226419433407;13395.464181432731;13561.728765424636;20346;23546.175883843982;25041.624375634197;2029.350607805503;2185.246090098929;2189.27753841232;2309.7459279479244;2467.605183170702;10069.144122749574;10128.442935638537;10148.594056237742;10446.738831529197;10587.994140556711;1684.6714890596338;1830.3959693301179;1858.8419984301352;1883.1808163448943;1923.471045462509;119275;122609.38695306555;124912.37543812314;126332;127770.3611481946;9276.443413395218;11354.886451135548;11603.187776855708;11629.418529073682;11662.88337116618;14674.55976320712;14714.55856324312;14727.11637301744;14734.115953042638;14742.336594853257;8167.183281671785;8411.327093832479;8424.283935865398;8522.57387130641;8532.018817836028;8315;8323.625436855356;8337.333013358917;8476.576171191538;8478.5336806475;4459.955400446019;4543.45478542577;4549.6360291176625;4581.427321584802;4626.935804764923;1515.6892836968395;1812.7304005898254;1831.8168183181842;1896.468988683171;1916.3005502991587;387.2777270390757;395.5312954149342;894.6063731957918;932.664240873285;955.4124213608719;11332.980031797179;11622.825657615143;11690.70773230659;11732.12009099321;12132.5146994121;384.97305188637085;431.833744008559;436.5002072626888;442.9182840648963;443.7892001299357;4857.295692124622;6021.397860213943;6068.4841788448475;6078.149059131725;6203.627782332984;551522.2423887855;591044;591271;594856;610361.9481902563;139420;140678.59321406655;142998.28500857428;143208;151657;443.7537166872352;453.2476089691097;453.5419226581111;453.58496975267263;454.7339806213336;10910;11075.5569777208;11424.143189261005;11457.598984035852;11543.133050427865;45617.069780928265;53766;54431.45568544422;55950.72024640014;56716.14925776034;64806;75498.24501755132;77341;80175.59912200402;80577.19422805696;7904.288614024766;8031.429942418604;8226.42415030966;8280.668773249243;8319.168083191633;7197.71209151628;9926.354786938826;10734.926507349202;12858.549950751678;13324.40040198174;10756.137904842037;11338;11349.659510214708;11390.829137563109;11475.655730328104;11022.779544408906;11068.28056176346;11277.266977646426;11377.523744810169;11542.59600913964;11113;11455.427228638702;11553.653390398302;11560;11570.363630000431;7925.484843485155;8029.638666260149;8171.713990010321;8394.87407688873;8423.368247381593;8175.509469431853;9691.418514889128;11034.393108379116;11176.944115279697;11225.831612525655 07:10:12 INFO - PROCESS | 1645 | |3;mootools.html;1292.8642492538281;1531.6630341324908;1644.8684105271573;1653.1238443624884;1843.714224295233;7585.696572137108;7825.413094017943;8093.716719914804;8496.235338819504;8501.23488886;7690.846183076335;8099.028116625998;8279.83440331193;8284.62719177637;8382.161783821615;2336.229044415343;2372.5017746273215;2375.3705268103968;2379.357573455166;2383.6067048936907;2366.6450032495177;2396.6524853896176;2409.626507891271;2410.517896420714;2416.093964763214;2275.0444813178506;2281.3840263128945;2307.573098976695;2307.9884600576975;2319.22306027481;2330.906763729449;2340.578695834749;2364.84628499147;2365.7515960824126;2368.171140100968;2352.6000579901456;2367;2390.952180956371;2392.2583998960376;2397.568437681217;8327.875081873777;8348.666053357858;8421.95789021051;8422.831543369159;8428.620712067972;4983.576396006308;5045.747712614355;5139.948600513984;5147.1507201312115;5211.166213405837;3338.0319707284857;3501.2472318451655;3543.85824567017;3567.6967457766123;3579.534660494145;1046.4035499765137;1069.1820757120809;1090.2695194219891;1103.6523495099018;1107.1364335818075;10933.507992140372;10943.288686235448;11036.613718519893;11051.392173430459;11054.557817687282;4346.717463364871;4366.497852746975;4501.392312037899;4529.048899731028;4542.02346495505;8707.216350528483;8711.956440217758;8721.520316382534;8729.25801306896;8756.737297881074;5076.0863044652315;5076.340075790124;5078.7206703631655;5083.212102124176;5084.237364395296;4323.610875021263;4442.6890117691455;4629.328747331618;4686.414198225222;4716.1510928033285;3658.70730341572;3683.4106542953;3767.5478942526524;3785.5268091488565;3796.7532110412735;1149.6148790155391;1154.3881742676394;1161.3264306702092;1163.6858048327074;1171.2855158353398;679.5345188545862;847.326375531454;878.6836738774036;909.5497728624373;916.0930678628243;5494.230807686927;5606.495415412633;5747.770089196385;5858.150568167592;6019.367436143936;923.8983711791698;929.3958926697566;929.419113054341;938.2775263047552;967.67099186277;3547.9290414191573;3834.367329390675;3866.9806650966566;3877.3214687429586;3941.7832019238645;9742.561584728704;10185.796284074277;10187.694369168938;10247.795044099077;10260.025297596716;9662.13040826329;10025.24810639205;10031.949840250752;10137.949310253549;10142.239332050125;7830.960845195737;8038.678452861937;8064.435489515678;8074.515529068275;8082.717104901418;5572.804951826666;5577.414371490935;5643.943560564342;5755.942440575541;5887.911681324698;9354.158125768714;9482.905170948477;9495.715128546155;9514.04859514043;9539.189168920719;9088.454692718458;9553.04469553039;9612.951935240279;9623.374480658735;9631.9036809631;6636.900446493403;6812.352826481477;6848.828779280558;6981.581105133709;7133.750318738819;7738.4969976951315;7865.685372585262;7954.801129971797;8079.434439589172;8079.555624440713;7055.3650171484815;7209.495335326476;7224.458165637493;7263.418926485974;7320.450966177665;7001.964990175016;7054.188768291507;7062.223155452999;7192.676329565077;7235.421166306788;6660.766873159416;6692.39768420825;6745.93254067453;6762.120924279812;6764.2221144569;4211.284081706179;4778.737169455713;4846.39420072491;4864.562189402971;4899.755012249302;4795.472498025145;4814.711117332971;4818.542238487338;4963.10664080469;5045.772940217626 07:10:12 INFO - PROCESS | 1645 | |4;prototype.html;276.38504327870476;282.7017496541149;308.5310328300984;314.3743949540415;316.14482823961185;4176.60322269384;4376.431063961681;4585.289280161576;4793.976030119845;5213.992612844054;4299.462567179103;4345.152695224432;4906.859609849699;5026.874328141798;5240.9213861792;3721.9441708374397;3917.6865850731874;3948.644621984028;3966.266240745457;3982.6813854891684;3986.3223252047223;3990.541087774914;3994.04143005678;4010.7393019453643;4016.7188296819236;3328.6172090209693;3388.84750186241;3911.941320880189;3978.8408463661417;3999.5400528939253;3505.94741078884;3814.4659747635355;3947.7039222058174;4003.97998010011;4009.4988126484336;3387.593488781362;3466.9945715742406;3469.1500582357485;3475.461303497962;3483.9477407838904;4563.794629241692;5075.695458272516;5097.23541468779;5104.668196567249;5123.538881500645;3907.882763517099;4014.0165659413337;4507.819687212507;4508.684392092555;4539.251023581105;5466;5472.972635136799;5475.808346707886;5512.283403157604;5522.475364840334;3200.567923330367;3742.7941463219513;3774.8867533974026;3778.735488515805;3785.242951409729;4947.653664243504;5201.401838788512;5522.502974732253;5638.182463542805;5677.403872593401;3822.3884178531857;3840.695582650387;3846.6345697158727;3847.5190601174854;3851.9807400963377;3312.703859659654;3898.2203559287686;3904.590018048121;3904.824282907219;3928.489296391508;4244.384564238168;4542.227821270392;4548.818047278071;4556.977215113903;4571.51999040096;4969.776360063805;5098.209777484496;5396.271503347077;5489.3687225969525;5536.446355364512;1116.7543140509074;1129.1136457880525;1176.5587155734156;1235.7837378458735;1271.2499625221164;722.608977717891;795.3239746215786;798.5129071266523;810.4569938141459;849.9405041647026;4361.258586040381;4814.20565606678;4894.486078961658;4897.730624815669;4932.950670493321;4641.930371044437;5086.313347698014;5172.965406918632;5328.413874473805;5365.302510673588;4412.161689279091;4749.786259618326;4815.783289751969;4858.6356023298395;4898.363212782316;2581.6772903387077;2638.907638232691;2805.2566069991467;2811.14260150656;2829.5383016775536;5313.203019547099;5320.574354051667;5470.11621748555;5472.589555783332;5508.807191748269;4586.747728874944;4636.095961287584;5057.797688092435;5334.973325133349;5406.945930540723;4497.775111244425;5073.949260507347;5470.343558772973;5471.425500322409;5480.47935446124;4633.698809577367;4661.114388266218;4915.525342397338;5296.311479507639;5298.258243845942;4909.281810242488;5176.722242213414;5207.760662914831;5234.424213336606;5268.552173065333;4649.883752906205;5320.680759154463;5473.589480789036;5561.023867934447;5577.721113944205;3026.44010857992;3453.637368076316;3536.328097661436;3619.3123306571665;3644.7084233261808;4908;5233.869153271046;5765.509931655856;5865.5922578581685;5878.94121058801;4995.475475075064;5632.436756324335;5708.628939118944;5724.656520608777;5731.799387021434;4427.645788336989;5023.925834906843;5415.943890941228;5593.608447408805;5660.349059858169;4607.792649330721;5182.797311142674;5266.631335806457;5449.863753406196;5706.28671416073;4865.391826021747;5381.919271211013;5444.945550544602;5452.591055670761;5554.250411120484;4941.851744447672;5414.512693857571;5451.773350995994;5456.59075569326;5459.372172200247 07:10:12 INFO - PROCESS | 1645 | |5;yui.html;747.1519824998625;759.3811043999142;777.8560966221248;812.6464987730334;818.905825830029;16126;16814;16864.91567542162;17033.403830865893;17053.317867285296;13435.731285374286;15658.138802365866;15819.525414237563;15865.603359916007;15866.603334916634;677.5121912223192;701.6947627781906;825.2160447574828;832.1595188859235;848.1433751910569;701.0745815523511;702.6908160409404;704.0214102397671;705.0517054561607;849.0787495567317;824.744329257932;895.476146454325;912.2884150362728;912.794621210229;913.1462082952428;904.9909500904972;906.3247880329197;906.8367693815111;907.9591418386156;908.2234689340651;668.5086461450878;669.8258452802257;669.9598024118568;670.2091531992247;670.7954074007425;14845.703085938329;15091.924540377227;15219;15245;15260.236988150658;13316;13653.249071301074;13961.092528985584;14191.716165676731;14239.00326977112;11357.602483913106;11409.429379205943;11455.369954652491;11691.88308116925;11870.990965767834;3701.61133081028;3711.814409279525;3738.420544815558;3796.1648437343742;3854.1713531590563;97112.54331185037;99932.50033749857;99940;101641;102939;10158.441285729208;10194.541245643964;10660;10835.295705779099;10982.780344393228;20224.393268201977;20379.898100509403;20395.592088158155;20414.69377959332;20440;7484;7569.545827250383;7578.4316176287;7841.725539606086;7880.605969701492;4326.697131200849;4339.522652508222;4397.34039894012;4441.977790111029;4495.820167193341;3412.9658703413143;3529.7529172957647;3531.1172206948263;3532.046347486216;3540.6813386794797;600.9849753756104;603.477991537317;631.315008349807;638.317000809139;674.9325067493212;587.2336600735995;591.3317950715664;643.1799455694028;672.6065251827638;687.9105716256954;9132.634694612141;10081.581879131008;10116.08955194036;10203.489825508696;10513.526891289757;670.580886945659;678.3081257117811;684.090160087093;684.9554778939353;696.6586372677351;3665.9266814663556;4084.65280451159;4584.747838868894;4641.535846415331;4642.117997580449;109702.90297097087;110715.44642276898;112907;114133.42933285446;116718.24922625997;98635;101036.49481752544;103349.44975825369;105686;105895;83971.16028839756;84283;84873;85823.57088214518;87127;6997.650117494207;8848.823023539622;8886.244669202932;8890.110988901059;9016.323775716717;50705.746471267405;52999.99999999846;54219;56268;58969.52576185458;79453.60273198597;81608.10351378936;82631.17368826235;84485;85801.57099214464;11035.558577656804;11509.13681473876;11558.653240402802;11580.768384632429;11755.941220293844;12568;12655.303958282382;12773.425195866022;12884.549040783528;12884.677883052624;11475;12010.159288849696;12033.699157521132;12521.060920431186;12544.560940367408;11863.406829658656;12081.697957551132;12373.13388062827;12499.062570307082;12499.562515312284;11482.94258528702;11849.466773995364;11939.462724177607;12341;12360.25838449696;9549.236061114954;9720.416774993522;10061;10371.481425928523;10422.322549034288;9814.950925245328;10175.694729158136;10188.694339169837;10189.235807314333;10271.7432064199 07:10:12 INFO - PROCESS | 1645 | __end_tp_report 07:10:12 INFO - PROCESS | 1645 | __start_cc_report 07:10:12 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1211 07:10:12 INFO - PROCESS | 1645 | __end_cc_report 07:10:12 INFO - PROCESS | 1645 | __startTimestamp1487171412146__endTimestamp 07:10:12 INFO - PROCESS | 1645 | 07:10:12 INFO - PROCESS | 1645 | ------- Summary: start ------- 07:10:12 INFO - PROCESS | 1645 | Number of tests: 6 07:10:12 INFO - PROCESS | 1645 | 07:10:12 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5804.84 Median:6063.12 stddev:612.03 (10.1%) stddev-sans-first:585.12 07:10:12 INFO - PROCESS | 1645 | Values: 3440.3 3469.9 3501.6 3512.7 3548.0 5826.9 5871.7 5885.6 5899.5 5925.3 5867.6 5937.6 5951.3 5963.9 5972.3 5307.2 5354.3 5374.0 5426.2 5449.3 5258.4 5310.3 5312.9 5431.1 5456.8 5334.4 5409.9 5410.7 5411.8 5412.7 5330.0 5343.1 5377.6 5404.5 5410.8 5180.9 5240.6 5346.3 5370.2 5387.5 4905.3 5735.3 5777.1 5777.3 5949.9 6171.6 6200.3 6212.5 6214.7 6228.7 6233.2 6236.8 6245.6 6246.4 6251.8 5707.5 5738.2 5838.2 5969.8 5975.4 6221.1 6273.9 6288.9 6301.2 6308.6 6238.8 6241.3 6264.3 6267.7 6270.5 6167.6 6226.5 6230.2 6232.4 6247.4 6158.3 6171.5 6211.5 6232.7 6252.6 6213.3 6213.5 6220.7 6237.2 6244.4 4990.6 5038.2 5046.3 5047.2 5064.4 4462.8 4489.3 4525.1 4542.9 4561.8 5739.3 5811.6 5818.6 5867.0 5917.2 6196.5 6204.6 6212.8 6214.8 6216.6 5503.5 5799.5 5812.4 5873.0 5894.5 5290.7 5345.6 5353.2 5353.7 5355.0 6199.0 6217.3 6218.6 6230.3 6239.6 6191.7 6214.3 6239.2 6243.3 6262.8 5255.4 6195.8 6319.3 6357.9 6362.5 6131.5 6155.4 6262.1 6266.3 6306.5 6156.1 6210.5 6220.3 6224.1 6240.3 5048.0 6239.4 6246.3 6265.5 6271.7 6230.0 6256.0 6261.9 6275.2 6289.6 5947.8 6016.7 6051.1 6063.1 6097.1 6230.8 6243.2 6245.4 6273.2 6274.5 5955.5 6004.2 6120.6 6121.7 6124.4 07:10:12 INFO - PROCESS | 1645 | 07:10:12 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:73010.87 Median:38590.52 stddev:170213.96 (441.1%) stddev-sans-first:170604.36 07:10:12 INFO - PROCESS | 1645 | Values: 487.0 512.7 528.0 546.3 561.5 29242.1 31514.4 39860.8 40775.0 40838.0 41737.6 42127.2 42138.4 42171.2 42247.4 9456.3 9628.4 9630.3 9631.8 9633.3 9399.7 9461.2 9477.1 9491.5 9504.2 9430.2 9474.9 9486.8 9488.1 9489.3 9445.2 9471.0 9480.7 9483.4 9508.8 9425.2 9509.5 9512.7 9527.6 9547.4 39905.6 40022.8 40131.0 40147.0 40185.0 3024.9 3442.3 3508.6 3520.2 3716.3 28460.6 29197.0 30071.4 31257.8 31496.7 3286.1 3309.3 3381.2 3399.8 3407.4 483859.2 488825.0 489535.0 490794.5 492521.0 33592.0 56036.2 56372.0 56408.4 56588.4 33989.3 34055.5 34283.3 34311.8 34351.5 14579.8 14732.0 14744.3 14750.9 14765.3 12316.0 12415.5 12420.7 12427.6 12435.7 7858.1 7876.8 7898.7 7954.4 7965.2 3300.7 3309.2 3309.6 3313.0 3333.8 826.9 965.3 980.1 1122.5 1153.2 29004.9 29229.3 29495.0 29688.4 29725.6 1016.7 1018.3 1022.5 1047.7 1203.8 14871.6 15272.8 15291.4 15612.0 15645.4 671331.0 715812.0 723732.4 727518.0 962005.0 57276.0 58129.1 58225.7 58296.4 58361.1 1250.3 1268.4 1288.1 1350.0 1355.1 23899.2 30151.2 30637.7 31342.2 32066.4 54820.9 55501.7 55609.7 55624.0 55788.2 605860.0 611729.0 611739.0 613062.0 613412.0 31329.9 33510.2 34136.1 41683.8 42330.4 44151.3 45218.3 45358.3 46364.5 46701.5 31166.0 37645.9 38347.6 38352.3 38604.4 37543.0 37674.2 37771.1 38576.6 38643.2 29892.0 29984.0 32132.0 36657.5 37758.9 30618.0 34041.0 34071.0 34091.7 34219.5 24686.6 24995.5 25036.7 25489.7 25555.0 07:10:12 INFO - PROCESS | 1645 | 07:10:12 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:34358.39 Median:397.63 stddev:99026.00 (24904.3%) stddev-sans-first:99270.92 07:10:12 INFO - PROCESS | 1645 | Values: 376.8 379.6 390.3 399.7 401.7 16375.8 18213.1 20166.7 20359.9 20377.0 18664.7 19136.6 19603.2 19630.4 19732.4 4689.4 5706.0 5964.6 5965.9 5986.5 4274.1 4510.4 4515.8 5832.7 5930.3 6219.5 6491.5 6535.5 6554.7 6585.5 6368.7 6460.5 6479.9 6526.6 6536.2 5036.3 5696.2 5705.6 5708.5 5730.2 13395.5 13561.7 20346.0 23546.2 25041.6 2029.4 2185.2 2189.3 2309.7 2467.6 10069.1 10128.4 10148.6 10446.7 10588.0 1684.7 1830.4 1858.8 1883.2 1923.5 119275.0 122609.4 124912.4 126332.0 127770.4 9276.4 11354.9 11603.2 11629.4 11662.9 14674.6 14714.6 14727.1 14734.1 14742.3 8167.2 8411.3 8424.3 8522.6 8532.0 8315.0 8323.6 8337.3 8476.6 8478.5 4460.0 4543.5 4549.6 4581.4 4626.9 1515.7 1812.7 1831.8 1896.5 1916.3 387.3 395.5 894.6 932.7 955.4 11333.0 11622.8 11690.7 11732.1 12132.5 385.0 431.8 436.5 442.9 443.8 4857.3 6021.4 6068.5 6078.1 6203.6 551522.2 591044.0 591271.0 594856.0 610361.9 139420.0 140678.6 142998.3 143208.0 151657.0 443.8 453.2 453.5 453.6 454.7 10910.0 11075.6 11424.1 11457.6 11543.1 45617.1 53766.0 54431.5 55950.7 56716.1 64806.0 75498.2 77341.0 80175.6 80577.2 7904.3 8031.4 8226.4 8280.7 8319.2 7197.7 9926.4 10734.9 12858.5 13324.4 10756.1 11338.0 11349.7 11390.8 11475.7 11022.8 11068.3 11277.3 11377.5 11542.6 11113.0 11455.4 11553.7 11560.0 11570.4 7925.5 8029.6 8171.7 8394.9 8423.4 8175.5 9691.4 11034.4 11176.9 11225.8 07:10:12 INFO - PROCESS | 1645 | 07:10:12 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5446.87 Median:5076.21 stddev:2974.45 (58.6%) stddev-sans-first:2966.41 07:10:12 INFO - PROCESS | 1645 | Values: 1292.9 1531.7 1644.9 1653.1 1843.7 7585.7 7825.4 8093.7 8496.2 8501.2 7690.8 8099.0 8279.8 8284.6 8382.2 2336.2 2372.5 2375.4 2379.4 2383.6 2366.6 2396.7 2409.6 2410.5 2416.1 2275.0 2281.4 2307.6 2308.0 2319.2 2330.9 2340.6 2364.8 2365.8 2368.2 2352.6 2367.0 2391.0 2392.3 2397.6 8327.9 8348.7 8422.0 8422.8 8428.6 4983.6 5045.7 5139.9 5147.2 5211.2 3338.0 3501.2 3543.9 3567.7 3579.5 1046.4 1069.2 1090.3 1103.7 1107.1 10933.5 10943.3 11036.6 11051.4 11054.6 4346.7 4366.5 4501.4 4529.0 4542.0 8707.2 8712.0 8721.5 8729.3 8756.7 5076.1 5076.3 5078.7 5083.2 5084.2 4323.6 4442.7 4629.3 4686.4 4716.2 3658.7 3683.4 3767.5 3785.5 3796.8 1149.6 1154.4 1161.3 1163.7 1171.3 679.5 847.3 878.7 909.5 916.1 5494.2 5606.5 5747.8 5858.2 6019.4 923.9 929.4 929.4 938.3 967.7 3547.9 3834.4 3867.0 3877.3 3941.8 9742.6 10185.8 10187.7 10247.8 10260.0 9662.1 10025.2 10031.9 10137.9 10142.2 7831.0 8038.7 8064.4 8074.5 8082.7 5572.8 5577.4 5643.9 5755.9 5887.9 9354.2 9482.9 9495.7 9514.0 9539.2 9088.5 9553.0 9613.0 9623.4 9631.9 6636.9 6812.4 6848.8 6981.6 7133.8 7738.5 7865.7 7954.8 8079.4 8079.6 7055.4 7209.5 7224.5 7263.4 7320.5 7002.0 7054.2 7062.2 7192.7 7235.4 6660.8 6692.4 6745.9 6762.1 6764.2 4211.3 4778.7 4846.4 4864.6 4899.8 4795.5 4814.7 4818.5 4963.1 5045.8 07:10:12 INFO - PROCESS | 1645 | 07:10:12 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4333.43 Median:4837.21 stddev:1326.25 (27.4%) stddev-sans-first:1294.54 07:10:12 INFO - PROCESS | 1645 | Values: 276.4 282.7 308.5 314.4 316.1 4176.6 4376.4 4585.3 4794.0 5214.0 4299.5 4345.2 4906.9 5026.9 5240.9 3721.9 3917.7 3948.6 3966.3 3982.7 3986.3 3990.5 3994.0 4010.7 4016.7 3328.6 3388.8 3911.9 3978.8 3999.5 3505.9 3814.5 3947.7 4004.0 4009.5 3387.6 3467.0 3469.2 3475.5 3483.9 4563.8 5075.7 5097.2 5104.7 5123.5 3907.9 4014.0 4507.8 4508.7 4539.3 5466.0 5473.0 5475.8 5512.3 5522.5 3200.6 3742.8 3774.9 3778.7 3785.2 4947.7 5201.4 5522.5 5638.2 5677.4 3822.4 3840.7 3846.6 3847.5 3852.0 3312.7 3898.2 3904.6 3904.8 3928.5 4244.4 4542.2 4548.8 4557.0 4571.5 4969.8 5098.2 5396.3 5489.4 5536.4 1116.8 1129.1 1176.6 1235.8 1271.2 722.6 795.3 798.5 810.5 849.9 4361.3 4814.2 4894.5 4897.7 4933.0 4641.9 5086.3 5173.0 5328.4 5365.3 4412.2 4749.8 4815.8 4858.6 4898.4 2581.7 2638.9 2805.3 2811.1 2829.5 5313.2 5320.6 5470.1 5472.6 5508.8 4586.7 4636.1 5057.8 5335.0 5406.9 4497.8 5073.9 5470.3 5471.4 5480.5 4633.7 4661.1 4915.5 5296.3 5298.3 4909.3 5176.7 5207.8 5234.4 5268.6 4649.9 5320.7 5473.6 5561.0 5577.7 3026.4 3453.6 3536.3 3619.3 3644.7 4908.0 5233.9 5765.5 5865.6 5878.9 4995.5 5632.4 5708.6 5724.7 5731.8 4427.6 5023.9 5415.9 5593.6 5660.3 4607.8 5182.8 5266.6 5449.9 5706.3 4865.4 5381.9 5444.9 5452.6 5554.3 4941.9 5414.5 5451.8 5456.6 5459.4 07:10:12 INFO - PROCESS | 1645 | 07:10:12 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:21444.45 Median:3767.29 stddev:32064.27 (851.1%) stddev-sans-first:32116.56 07:10:12 INFO - PROCESS | 1645 | Values: 747.2 759.4 777.9 812.6 818.9 16126.0 16814.0 16864.9 17033.4 17053.3 13435.7 15658.1 15819.5 15865.6 15866.6 677.5 701.7 825.2 832.2 848.1 701.1 702.7 704.0 705.1 849.1 824.7 895.5 912.3 912.8 913.1 905.0 906.3 906.8 908.0 908.2 668.5 669.8 670.0 670.2 670.8 14845.7 15091.9 15219.0 15245.0 15260.2 13316.0 13653.2 13961.1 14191.7 14239.0 11357.6 11409.4 11455.4 11691.9 11871.0 3701.6 3711.8 3738.4 3796.2 3854.2 97112.5 99932.5 99940.0 101641.0 102939.0 10158.4 10194.5 10660.0 10835.3 10982.8 20224.4 20379.9 20395.6 20414.7 20440.0 7484.0 7569.5 7578.4 7841.7 7880.6 4326.7 4339.5 4397.3 4442.0 4495.8 3413.0 3529.8 3531.1 3532.0 3540.7 601.0 603.5 631.3 638.3 674.9 587.2 591.3 643.2 672.6 687.9 9132.6 10081.6 10116.1 10203.5 10513.5 670.6 678.3 684.1 685.0 696.7 3665.9 4084.7 4584.7 4641.5 4642.1 109702.9 110715.4 112907.0 114133.4 116718.2 98635.0 101036.5 103349.4 105686.0 105895.0 83971.2 84283.0 84873.0 85823.6 87127.0 6997.7 8848.8 8886.2 8890.1 9016.3 50705.7 53000.0 54219.0 56268.0 58969.5 79453.6 81608.1 82631.2 84485.0 85801.6 11035.6 11509.1 11558.7 11580.8 11755.9 12568.0 12655.3 12773.4 12884.5 12884.7 11475.0 12010.2 12033.7 12521.1 12544.6 11863.4 12081.7 12373.1 12499.1 12499.6 11482.9 11849.5 11939.5 12341.0 12360.3 9549.2 9720.4 10061.0 10371.5 10422.3 9815.0 10175.7 10188.7 10189.2 10271.7 07:10:12 INFO - PROCESS | 1645 | -------- Summary: end -------- 07:10:12 INFO - PROCESS | 1645 | 07:10:12 INFO - TEST-INFO | 1645: exit 0 07:10:12 INFO - TEST-OK | dromaeo_css | took 1117669ms 07:10:12 INFO - TEST-START | kraken 07:10:12 INFO - operating with platform_type : mac_ 07:10:12 INFO - Initialising browser for kraken test... 07:10:12 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmpGDXsSj/profile http://localhost:49241/getInfo.html) 07:10:15 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 07:10:15 INFO - PROCESS | 1650 | colorDepth:24 07:10:15 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 07:10:15 INFO - PROCESS | 1650 | __metrics 07:10:15 INFO - PROCESS | 1650 | 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" 07:10:15 INFO - PROCESS | 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:10:16 INFO - TEST-INFO | 1650: exit 0 07:10:16 INFO - Browser initialized. 07:10:16 INFO - Running cycle 1/1 for kraken test... 07:10:16 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmpGDXsSj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:28 INFO - PROCESS | 1652 | RSS: Main: 172044288 07:10:28 INFO - PROCESS | 1652 | 07:10:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 07:10:32 INFO - PROCESS | 1652 | RSS: Main: 221974528 07:10:32 INFO - PROCESS | 1652 | 07:10:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 07:10:35 INFO - PROCESS | 1652 | RSS: Main: 234426368 07:10:35 INFO - PROCESS | 1652 | 07:10:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 07:10:39 INFO - PROCESS | 1652 | RSS: Main: 332005376 07:10:39 INFO - PROCESS | 1652 | 07:10:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 07:10:41 INFO - PROCESS | 1652 | RSS: Main: 233549824 07:10:41 INFO - PROCESS | 1652 | 07:10:43 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:10:44 INFO - PROCESS | 1652 | RSS: Main: 234377216 07:10:44 INFO - PROCESS | 1652 | 07:10:46 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 07:10:47 INFO - PROCESS | 1652 | RSS: Main: 274857984 07:10:47 INFO - PROCESS | 1652 | 07:10:50 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 07:10:50 INFO - PROCESS | 1652 | RSS: Main: 275025920 07:10:50 INFO - PROCESS | 1652 | 07:10:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 07:10:54 INFO - PROCESS | 1652 | RSS: Main: 271949824 07:10:54 INFO - PROCESS | 1652 | 07:10:55 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:10:56 INFO - PROCESS | 1652 | RSS: Main: 248610816 07:10:56 INFO - PROCESS | 1652 | 07:10:58 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:10:58 INFO - PROCESS | 1652 | RSS: Main: 250105856 07:10:58 INFO - PROCESS | 1652 | 07:11:00 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:11:01 INFO - PROCESS | 1652 | RSS: Main: 254205952 07:11:01 INFO - PROCESS | 1652 | 07:11:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:11:05 INFO - PROCESS | 1652 | RSS: Main: 270315520 07:11:05 INFO - PROCESS | 1652 | 07:11:08 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:11:08 INFO - PROCESS | 1652 | RSS: Main: 263782400 07:11:08 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 07:11:10 INFO - PROCESS | 1652 | RSS: Main: 307937280 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | __start_tp_report 07:11:10 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 07:11:10 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 07:11:10 INFO - PROCESS | 1652 | |i|pagename|runs| 07:11:10 INFO - PROCESS | 1652 | |0;ai-astar;115;114;122;164;161;113;113;112;112;147 07:11:10 INFO - PROCESS | 1652 | |1;audio-beat-detection;143;108;109;143;113;108;106;118;168;134 07:11:10 INFO - PROCESS | 1652 | |2;audio-dft;183;185;180;185;182;183;182;182;183;184 07:11:10 INFO - PROCESS | 1652 | |3;audio-fft;81;59;59;88;59;60;59;59;82;57 07:11:10 INFO - PROCESS | 1652 | |4;audio-oscillator;81;64;92;68;67;67;88;67;70;88 07:11:10 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;88;85;90;86;89;85;89;86;90;86 07:11:10 INFO - PROCESS | 1652 | |6;imaging-darkroom;94;95;96;95;94;96;95;95;97;95 07:11:10 INFO - PROCESS | 1652 | |7;imaging-desaturate;82;81;78;82;84;80;85;82;82;80 07:11:10 INFO - PROCESS | 1652 | |8;json-parse-financial;55;53;52;53;60;57;59;56;56;57 07:11:10 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;61;73;63;73;70;66;67;65;66;66 07:11:10 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;83;82;82;83;81;80;72;82;91;97 07:11:10 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;159;130;145;145;143;142;139;139;179;152 07:11:10 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;161;163;163;163;161;165;162;160;161;163 07:11:10 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;64;64;65;66;66;66;64;62;64;65 07:11:10 INFO - PROCESS | 1652 | __end_tp_report 07:11:10 INFO - PROCESS | 1652 | __start_cc_report 07:11:10 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1980 07:11:10 INFO - PROCESS | 1652 | __end_cc_report 07:11:10 INFO - PROCESS | 1652 | __startTimestamp1487171470590__endTimestamp 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | ------- Summary: start ------- 07:11:10 INFO - PROCESS | 1652 | Number of tests: 14 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:127.30 Median:118.50 stddev:21.35 (18.0%) stddev-sans-first:22.18 07:11:10 INFO - PROCESS | 1652 | Values: 115.0 114.0 122.0 164.0 161.0 113.0 113.0 112.0 112.0 147.0 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:126.00 stddev:20.99 (16.7%) stddev-sans-first:21.23 07:11:10 INFO - PROCESS | 1652 | Values: 143.0 108.0 109.0 143.0 113.0 108.0 106.0 118.0 168.0 134.0 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.00 stddev:1.52 (0.8%) stddev-sans-first:1.62 07:11:10 INFO - PROCESS | 1652 | Values: 183.0 185.0 180.0 185.0 182.0 183.0 182.0 182.0 183.0 184.0 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:66.30 Median:59.50 stddev:12.14 (20.4%) stddev-sans-first:11.65 07:11:10 INFO - PROCESS | 1652 | Values: 81.0 59.0 59.0 88.0 59.0 60.0 59.0 59.0 82.0 57.0 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:75.50 stddev:10.80 (14.3%) stddev-sans-first:11.25 07:11:10 INFO - PROCESS | 1652 | Values: 81.0 64.0 92.0 68.0 67.0 67.0 88.0 67.0 70.0 88.0 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.50 stddev:2.01 (2.3%) stddev-sans-first:2.12 07:11:10 INFO - PROCESS | 1652 | Values: 88.0 85.0 90.0 86.0 89.0 85.0 89.0 86.0 90.0 86.0 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.87 07:11:10 INFO - PROCESS | 1652 | Values: 94.0 95.0 96.0 95.0 94.0 96.0 95.0 95.0 97.0 95.0 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:81.60 Median:82.00 stddev:2.01 (2.5%) stddev-sans-first:2.13 07:11:10 INFO - PROCESS | 1652 | Values: 82.0 81.0 78.0 82.0 84.0 80.0 85.0 82.0 82.0 80.0 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.50 stddev:2.62 (4.6%) stddev-sans-first:2.76 07:11:10 INFO - PROCESS | 1652 | Values: 55.0 53.0 52.0 53.0 60.0 57.0 59.0 56.0 56.0 57.0 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:66.50 stddev:3.94 (5.9%) stddev-sans-first:3.54 07:11:10 INFO - PROCESS | 1652 | Values: 61.0 73.0 63.0 73.0 70.0 66.0 67.0 65.0 66.0 66.0 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.50 stddev:6.63 (8.0%) stddev-sans-first:7.04 07:11:10 INFO - PROCESS | 1652 | Values: 83.0 82.0 82.0 83.0 81.0 80.0 72.0 82.0 91.0 97.0 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:145.00 stddev:13.57 (9.4%) stddev-sans-first:13.72 07:11:10 INFO - PROCESS | 1652 | Values: 159.0 130.0 145.0 145.0 143.0 142.0 139.0 139.0 179.0 152.0 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:163.00 stddev:1.48 (0.9%) stddev-sans-first:1.50 07:11:10 INFO - PROCESS | 1652 | Values: 161.0 163.0 163.0 163.0 161.0 165.0 162.0 160.0 161.0 163.0 07:11:10 INFO - PROCESS | 1652 | 07:11:10 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 07:11:10 INFO - PROCESS | 1652 | Values: 64.0 64.0 65.0 66.0 66.0 66.0 64.0 62.0 64.0 65.0 07:11:10 INFO - PROCESS | 1652 | -------- Summary: end -------- 07:11:10 INFO - PROCESS | 1652 | 07:11:11 INFO - TEST-INFO | 1652: exit 0 07:11:11 INFO - TEST-OK | kraken | took 58827ms 07:11:11 INFO - SUITE-END | took 1176s 07:11:11 INFO - Completed test suite (00:19:36) 07:11:11 INFO - javascript benchmark 07:11:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3440.260344026034, 3469.861205551778, 3501.5973163086237, 3512.6838584527386, 3547.982260088699, 5826.883462330751, 5871.70641467927, 5885.617434866731, 5899.498542623872, 5925.259342582177, 5867.647941123525, 5937.554683398752, 5951.345352011286, 5963.850903727409, 5972.313183983843, 5307.150855863053, 5354.27717258169, 5374.0, 5426.240326354294, 5449.291592093023, 5258.368995720519, 5310.256564081032, 5312.867178320535, 5431.103867861798, 5456.781728730866, 5334.439883812202, 5409.891802163955, 5410.702411367373, 5411.83764487066, 5412.702301373423, 5329.973350133263, 5343.091674415358, 5377.596680248997, 5404.540614047791, 5410.783568657249, 5180.860210753628, 5240.580753539746, 5346.27825243591, 5370.221317908881, 5387.488188622075, 4905.337779399771, 5735.340435849847, 5777.133429985493, 5777.306723193202, 5949.91075133869, 6171.59884607499, 6200.255969283715, 6212.502999760009, 6214.65819379934, 6228.657423841687, 6233.158523599347, 6236.781712640036, 6245.62526248422, 6246.375362463763, 6251.812445626639, 5707.4577915098, 5738.1679656450415, 5838.241028666246, 5969.761209551612, 5975.43233392827, 6221.129041934133, 6273.8745225095245, 6288.9056664150075, 6301.212348456443, 6308.589941653778, 6238.812835614939, 6241.34465881085, 6264.310925798159, 6267.6866156691985, 6270.498360131179, 6167.599106058092, 6226.501879849601, 6230.158928544589, 6232.439080482688, 6247.375262473716, 6158.291796443466, 6171.506279497629, 6211.472024877846, 6232.719527621268, 6252.562320637603, 6213.254409470802, 6213.5339849510565, 6220.688965551704, 6237.157983672146, 6244.438000579969, 4990.6257030722845, 5038.2190760432195, 5046.34397528319, 5047.2429135629945, 5064.392272927273, 4462.843800466968, 4489.304157855538, 4525.117602067565, 4542.931856022163, 4561.840335588238, 5739.311282646109, 5811.564132690065, 5818.592698511148, 5867.002609556385, 5917.201177841022, 6196.504279657706, 6204.627722336674, 6212.844678882973, 6214.844628884223, 6216.627002379872, 5503.532199763065, 5799.536037117021, 5812.360640329561, 5873.030949893306, 5894.528437725057, 5290.65610735301, 5345.572354211654, 5353.197020446964, 5353.732313384316, 5355.009323275207, 6199.0, 6217.316095229431, 6218.595791273553, 6230.345813689588, 6239.625622462667, 6191.690415479118, 6214.316425193316, 6239.1577137087725, 6243.282022567281, 6262.780802671885, 5255.448177941414, 6195.845103872259, 6319.304876463677, 6357.936420635734, 6362.45919096882, 6131.540134489842, 6155.384461553809, 6262.123302737529, 6266.279377871603, 6306.495480361468, 6156.1381406604005, 6210.5031597473, 6220.284667263141, 6224.06639004153, 6240.313565507699, 5048.0, 6239.407256310643, 6246.281677607133, 6265.498760099273, 6271.749130034747, 6229.972054610938, 6256.0, 6261.906071409024, 6275.246970363585, 6289.622622642656, 5947.791827286197, 6016.669083200466, 6051.0923361496125, 6063.120847477179, 6097.146399503984, 6230.7507699693315, 6243.188385509855, 6245.375462453719, 6273.247210334789, 6274.46667033289, 5955.464008239279, 6004.219451471281, 6120.60216085953, 6121.724522396414, 6124.448799608057], "value": 5768.445686789137, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.97565121743907, 512.6795752654591, 527.9815206467774, 546.295279089974, 561.4722161168502, 29242.122736317917, 31514.369712605763, 39860.80069599651, 40774.98062548438, 40837.979050523754, 41737.58262417375, 42127.157456850924, 42138.36792448116, 42171.156576868445, 42247.366289505604, 9456.338056336042, 9628.422294662343, 9630.3258771886, 9631.759206019835, 9633.325667203299, 9399.671011514598, 9461.195798357114, 9477.14705676489, 9491.52542372882, 9504.192143667762, 9430.198433133157, 9474.905250947471, 9486.814148231471, 9488.146066853982, 9489.335746497747, 9445.244380449547, 9470.952645236799, 9480.668176613786, 9483.383580067342, 9508.809823803555, 9425.245980321557, 9509.476978766164, 9512.667056653054, 9527.571259293349, 9547.379420337656, 39905.60094399077, 40022.799886000386, 40131.0, 40147.0, 40185.0, 3024.8807941061727, 3442.3115376924466, 3508.6491350864962, 3520.1903562180587, 3716.3155926710706, 28460.573091403647, 29197.0, 30071.398572028436, 31257.843710781526, 31496.685033149603, 3286.079897628668, 3309.321589074258, 3381.2223188666744, 3399.847006884696, 3407.369636617234, 483859.1614083849, 488825.0, 489535.0, 490794.54602727114, 492521.0, 33591.99224023283, 56036.15945760817, 56372.0, 56408.43591564114, 56588.43411565832, 33989.32021359559, 34055.489167662505, 34283.314333713184, 34311.82844085764, 34351.484727729105, 14579.781303280459, 14732.0, 14744.262786860614, 14750.926245368704, 14765.261736913111, 12316.0, 12415.503379864886, 12420.689482763004, 12427.627171184879, 12435.689107772198, 7858.1356050834365, 7876.803079923047, 7898.684052637945, 7954.443188976716, 7965.243301886311, 3300.66993300668, 3309.1561651778643, 3309.5532103166247, 3312.966870331314, 3333.81664008477, 826.8594338962391, 965.2663975378622, 980.1423754215061, 1122.4892673833385, 1153.1581945180067, 29004.854975724986, 29229.26926826804, 29495.0, 29688.40623187524, 29725.55411668827, 1016.7051555049101, 1018.2668478695327, 1022.4529876516028, 1047.7485403503103, 1203.7712834561405, 14871.628209294855, 15272.770908436383, 15291.388344466319, 15611.985220960602, 15645.374185032699, 671331.0, 715812.0, 723732.3813380899, 727518.0, 962005.0, 57276.0, 58129.128063079086, 58225.70887145537, 58296.417035829945, 58361.08194590254, 1250.349818094604, 1268.4482250221183, 1288.0661520397637, 1350.0279798545032, 1355.0785465883098, 23899.163529276393, 30151.246218844706, 30637.693623063486, 31342.216444589067, 32066.35867282688, 54820.903581928935, 55501.7224913889, 55609.72195138998, 55624.0, 55788.163177551556, 605860.0, 611729.0, 611739.0, 613062.0, 613412.0, 31329.903453379935, 33510.16224594405, 34136.14659633529, 41683.7915810419, 42330.36504452374, 44151.33772993343, 45218.32172517349, 45358.31962520499, 46364.536354636024, 46701.53298467108, 31166.0, 37645.870623881325, 38347.616523834404, 38352.285473571, 38604.420933685455, 37543.0, 37674.246515070095, 37771.05572360713, 38576.614233858425, 38643.227135456575, 29891.95378161754, 29983.950561731108, 32132.0, 36657.45013824848, 37758.86723398302, 30618.0, 34041.0, 34070.97787066392, 34091.65908340984, 34219.4867076999, 24686.629700554866, 24995.500089997735, 25036.74963250344, 25489.745102548735, 25555.0], "value": 18742.748051989773, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.8323096222181, 379.62227583554363, 390.33253137135495, 399.72019586289605, 401.69671897717217, 16375.83624163758, 18213.08934553272, 20166.6974995375, 20359.898200509015, 20376.98115094245, 18664.72002919954, 19136.617267654674, 19603.21587136513, 19630.41108766736, 19732.408027759153, 4689.39037925071, 5706.0, 5964.642121472704, 5965.85085372867, 5986.461218490335, 4274.081072569397, 4510.391097201868, 4515.7516336601475, 5832.650040997532, 5930.347661757203, 6219.502439804827, 6491.513136514756, 6535.509836762262, 6554.737810487575, 6585.539012269143, 6368.745250189987, 6460.515461340395, 6479.902801457982, 6526.608403495806, 6536.248331441898, 5036.345275114211, 5696.23100881384, 5705.572082093818, 5708.457696518865, 5730.226419433407, 13395.464181432731, 13561.728765424636, 20346.0, 23546.175883843982, 25041.624375634197, 2029.350607805503, 2185.246090098929, 2189.27753841232, 2309.7459279479244, 2467.605183170702, 10069.144122749574, 10128.442935638537, 10148.594056237742, 10446.738831529197, 10587.994140556711, 1684.6714890596338, 1830.3959693301179, 1858.8419984301352, 1883.1808163448943, 1923.471045462509, 119275.0, 122609.38695306555, 124912.37543812314, 126332.0, 127770.3611481946, 9276.443413395218, 11354.886451135548, 11603.187776855708, 11629.418529073682, 11662.88337116618, 14674.55976320712, 14714.55856324312, 14727.11637301744, 14734.115953042638, 14742.336594853257, 8167.183281671785, 8411.327093832479, 8424.283935865398, 8522.57387130641, 8532.018817836028, 8315.0, 8323.625436855356, 8337.333013358917, 8476.576171191538, 8478.5336806475, 4459.955400446019, 4543.45478542577, 4549.6360291176625, 4581.427321584802, 4626.935804764923, 1515.6892836968395, 1812.7304005898254, 1831.8168183181842, 1896.468988683171, 1916.3005502991587, 387.2777270390757, 395.5312954149342, 894.6063731957918, 932.664240873285, 955.4124213608719, 11332.980031797179, 11622.825657615143, 11690.70773230659, 11732.12009099321, 12132.5146994121, 384.97305188637085, 431.833744008559, 436.5002072626888, 442.9182840648963, 443.7892001299357, 4857.295692124622, 6021.397860213943, 6068.4841788448475, 6078.149059131725, 6203.627782332984, 551522.2423887855, 591044.0, 591271.0, 594856.0, 610361.9481902563, 139420.0, 140678.59321406655, 142998.28500857428, 143208.0, 151657.0, 443.7537166872352, 453.2476089691097, 453.5419226581111, 453.58496975267263, 454.7339806213336, 10910.0, 11075.5569777208, 11424.143189261005, 11457.598984035852, 11543.133050427865, 45617.069780928265, 53766.0, 54431.45568544422, 55950.72024640014, 56716.14925776034, 64806.0, 75498.24501755132, 77341.0, 80175.59912200402, 80577.19422805696, 7904.288614024766, 8031.429942418604, 8226.42415030966, 8280.668773249243, 8319.168083191633, 7197.71209151628, 9926.354786938826, 10734.926507349202, 12858.549950751678, 13324.40040198174, 10756.137904842037, 11338.0, 11349.659510214708, 11390.829137563109, 11475.655730328104, 11022.779544408906, 11068.28056176346, 11277.266977646426, 11377.523744810169, 11542.59600913964, 11113.0, 11455.427228638702, 11553.653390398302, 11560.0, 11570.363630000431, 7925.484843485155, 8029.638666260149, 8171.713990010321, 8394.87407688873, 8423.368247381593, 8175.509469431853, 9691.418514889128, 11034.393108379116, 11176.944115279697, 11225.831612525655], "value": 8549.950219942397, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.8642492538281, 1531.6630341324908, 1644.8684105271573, 1653.1238443624884, 1843.714224295233, 7585.696572137108, 7825.413094017943, 8093.716719914804, 8496.235338819504, 8501.23488886, 7690.846183076335, 8099.028116625998, 8279.83440331193, 8284.62719177637, 8382.161783821615, 2336.229044415343, 2372.5017746273215, 2375.3705268103968, 2379.357573455166, 2383.6067048936907, 2366.6450032495177, 2396.6524853896176, 2409.626507891271, 2410.517896420714, 2416.093964763214, 2275.0444813178506, 2281.3840263128945, 2307.573098976695, 2307.9884600576975, 2319.22306027481, 2330.906763729449, 2340.578695834749, 2364.84628499147, 2365.7515960824126, 2368.171140100968, 2352.6000579901456, 2367.0, 2390.952180956371, 2392.2583998960376, 2397.568437681217, 8327.875081873777, 8348.666053357858, 8421.95789021051, 8422.831543369159, 8428.620712067972, 4983.576396006308, 5045.747712614355, 5139.948600513984, 5147.1507201312115, 5211.166213405837, 3338.0319707284857, 3501.2472318451655, 3543.85824567017, 3567.6967457766123, 3579.534660494145, 1046.4035499765137, 1069.1820757120809, 1090.2695194219891, 1103.6523495099018, 1107.1364335818075, 10933.507992140372, 10943.288686235448, 11036.613718519893, 11051.392173430459, 11054.557817687282, 4346.717463364871, 4366.497852746975, 4501.392312037899, 4529.048899731028, 4542.02346495505, 8707.216350528483, 8711.956440217758, 8721.520316382534, 8729.25801306896, 8756.737297881074, 5076.0863044652315, 5076.340075790124, 5078.7206703631655, 5083.212102124176, 5084.237364395296, 4323.610875021263, 4442.6890117691455, 4629.328747331618, 4686.414198225222, 4716.1510928033285, 3658.70730341572, 3683.4106542953, 3767.5478942526524, 3785.5268091488565, 3796.7532110412735, 1149.6148790155391, 1154.3881742676394, 1161.3264306702092, 1163.6858048327074, 1171.2855158353398, 679.5345188545862, 847.326375531454, 878.6836738774036, 909.5497728624373, 916.0930678628243, 5494.230807686927, 5606.495415412633, 5747.770089196385, 5858.150568167592, 6019.367436143936, 923.8983711791698, 929.3958926697566, 929.419113054341, 938.2775263047552, 967.67099186277, 3547.9290414191573, 3834.367329390675, 3866.9806650966566, 3877.3214687429586, 3941.7832019238645, 9742.561584728704, 10185.796284074277, 10187.694369168938, 10247.795044099077, 10260.025297596716, 9662.13040826329, 10025.24810639205, 10031.949840250752, 10137.949310253549, 10142.239332050125, 7830.960845195737, 8038.678452861937, 8064.435489515678, 8074.515529068275, 8082.717104901418, 5572.804951826666, 5577.414371490935, 5643.943560564342, 5755.942440575541, 5887.911681324698, 9354.158125768714, 9482.905170948477, 9495.715128546155, 9514.04859514043, 9539.189168920719, 9088.454692718458, 9553.04469553039, 9612.951935240279, 9623.374480658735, 9631.9036809631, 6636.900446493403, 6812.352826481477, 6848.828779280558, 6981.581105133709, 7133.750318738819, 7738.4969976951315, 7865.685372585262, 7954.801129971797, 8079.434439589172, 8079.555624440713, 7055.3650171484815, 7209.495335326476, 7224.458165637493, 7263.418926485974, 7320.450966177665, 7001.964990175016, 7054.188768291507, 7062.223155452999, 7192.676329565077, 7235.421166306788, 6660.766873159416, 6692.39768420825, 6745.93254067453, 6762.120924279812, 6764.2221144569, 4211.284081706179, 4778.737169455713, 4846.39420072491, 4864.562189402971, 4899.755012249302, 4795.472498025145, 4814.711117332971, 4818.542238487338, 4963.10664080469, 5045.772940217626], "value": 4418.542667115997, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.38504327870476, 282.7017496541149, 308.5310328300984, 314.3743949540415, 316.14482823961185, 4176.60322269384, 4376.431063961681, 4585.289280161576, 4793.976030119845, 5213.992612844054, 4299.462567179103, 4345.152695224432, 4906.859609849699, 5026.874328141798, 5240.9213861792, 3721.9441708374397, 3917.6865850731874, 3948.644621984028, 3966.266240745457, 3982.6813854891684, 3986.3223252047223, 3990.541087774914, 3994.04143005678, 4010.7393019453643, 4016.7188296819236, 3328.6172090209693, 3388.84750186241, 3911.941320880189, 3978.8408463661417, 3999.5400528939253, 3505.94741078884, 3814.4659747635355, 3947.7039222058174, 4003.97998010011, 4009.4988126484336, 3387.593488781362, 3466.9945715742406, 3469.1500582357485, 3475.461303497962, 3483.9477407838904, 4563.794629241692, 5075.695458272516, 5097.23541468779, 5104.668196567249, 5123.538881500645, 3907.882763517099, 4014.0165659413337, 4507.819687212507, 4508.684392092555, 4539.251023581105, 5466.0, 5472.972635136799, 5475.808346707886, 5512.283403157604, 5522.475364840334, 3200.567923330367, 3742.7941463219513, 3774.8867533974026, 3778.735488515805, 3785.242951409729, 4947.653664243504, 5201.401838788512, 5522.502974732253, 5638.182463542805, 5677.403872593401, 3822.3884178531857, 3840.695582650387, 3846.6345697158727, 3847.5190601174854, 3851.9807400963377, 3312.703859659654, 3898.2203559287686, 3904.590018048121, 3904.824282907219, 3928.489296391508, 4244.384564238168, 4542.227821270392, 4548.818047278071, 4556.977215113903, 4571.51999040096, 4969.776360063805, 5098.209777484496, 5396.271503347077, 5489.3687225969525, 5536.446355364512, 1116.7543140509074, 1129.1136457880525, 1176.5587155734156, 1235.7837378458735, 1271.2499625221164, 722.608977717891, 795.3239746215786, 798.5129071266523, 810.4569938141459, 849.9405041647026, 4361.258586040381, 4814.20565606678, 4894.486078961658, 4897.730624815669, 4932.950670493321, 4641.930371044437, 5086.313347698014, 5172.965406918632, 5328.413874473805, 5365.302510673588, 4412.161689279091, 4749.786259618326, 4815.783289751969, 4858.6356023298395, 4898.363212782316, 2581.6772903387077, 2638.907638232691, 2805.2566069991467, 2811.14260150656, 2829.5383016775536, 5313.203019547099, 5320.574354051667, 5470.11621748555, 5472.589555783332, 5508.807191748269, 4586.747728874944, 4636.095961287584, 5057.797688092435, 5334.973325133349, 5406.945930540723, 4497.775111244425, 5073.949260507347, 5470.343558772973, 5471.425500322409, 5480.47935446124, 4633.698809577367, 4661.114388266218, 4915.525342397338, 5296.311479507639, 5298.258243845942, 4909.281810242488, 5176.722242213414, 5207.760662914831, 5234.424213336606, 5268.552173065333, 4649.883752906205, 5320.680759154463, 5473.589480789036, 5561.023867934447, 5577.721113944205, 3026.44010857992, 3453.637368076316, 3536.328097661436, 3619.3123306571665, 3644.7084233261808, 4908.0, 5233.869153271046, 5765.509931655856, 5865.5922578581685, 5878.94121058801, 4995.475475075064, 5632.436756324335, 5708.628939118944, 5724.656520608777, 5731.799387021434, 4427.645788336989, 5023.925834906843, 5415.943890941228, 5593.608447408805, 5660.349059858169, 4607.792649330721, 5182.797311142674, 5266.631335806457, 5449.863753406196, 5706.28671416073, 4865.391826021747, 5381.919271211013, 5444.945550544602, 5452.591055670761, 5554.250411120484, 4941.851744447672, 5414.512693857571, 5451.773350995994, 5456.59075569326, 5459.372172200247], "value": 3904.2921833468167, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.1519824998625, 759.3811043999142, 777.8560966221248, 812.6464987730334, 818.905825830029, 16126.0, 16814.0, 16864.91567542162, 17033.403830865893, 17053.317867285296, 13435.731285374286, 15658.138802365866, 15819.525414237563, 15865.603359916007, 15866.603334916634, 677.5121912223192, 701.6947627781906, 825.2160447574828, 832.1595188859235, 848.1433751910569, 701.0745815523511, 702.6908160409404, 704.0214102397671, 705.0517054561607, 849.0787495567317, 824.744329257932, 895.476146454325, 912.2884150362728, 912.794621210229, 913.1462082952428, 904.9909500904972, 906.3247880329197, 906.8367693815111, 907.9591418386156, 908.2234689340651, 668.5086461450878, 669.8258452802257, 669.9598024118568, 670.2091531992247, 670.7954074007425, 14845.703085938329, 15091.924540377227, 15219.0, 15245.0, 15260.236988150658, 13316.0, 13653.249071301074, 13961.092528985584, 14191.716165676731, 14239.00326977112, 11357.602483913106, 11409.429379205943, 11455.369954652491, 11691.88308116925, 11870.990965767834, 3701.61133081028, 3711.814409279525, 3738.420544815558, 3796.1648437343742, 3854.1713531590563, 97112.54331185037, 99932.50033749857, 99940.0, 101641.0, 102939.0, 10158.441285729208, 10194.541245643964, 10660.0, 10835.295705779099, 10982.780344393228, 20224.393268201977, 20379.898100509403, 20395.592088158155, 20414.69377959332, 20440.0, 7484.0, 7569.545827250383, 7578.4316176287, 7841.725539606086, 7880.605969701492, 4326.697131200849, 4339.522652508222, 4397.34039894012, 4441.977790111029, 4495.820167193341, 3412.9658703413143, 3529.7529172957647, 3531.1172206948263, 3532.046347486216, 3540.6813386794797, 600.9849753756104, 603.477991537317, 631.315008349807, 638.317000809139, 674.9325067493212, 587.2336600735995, 591.3317950715664, 643.1799455694028, 672.6065251827638, 687.9105716256954, 9132.634694612141, 10081.581879131008, 10116.08955194036, 10203.489825508696, 10513.526891289757, 670.580886945659, 678.3081257117811, 684.090160087093, 684.9554778939353, 696.6586372677351, 3665.9266814663556, 4084.65280451159, 4584.747838868894, 4641.535846415331, 4642.117997580449, 109702.90297097087, 110715.44642276898, 112907.0, 114133.42933285446, 116718.24922625997, 98635.0, 101036.49481752544, 103349.44975825369, 105686.0, 105895.0, 83971.16028839756, 84283.0, 84873.0, 85823.57088214518, 87127.0, 6997.650117494207, 8848.823023539622, 8886.244669202932, 8890.110988901059, 9016.323775716717, 50705.746471267405, 52999.99999999846, 54219.0, 56268.0, 58969.52576185458, 79453.60273198597, 81608.10351378936, 82631.17368826235, 84485.0, 85801.57099214464, 11035.558577656804, 11509.13681473876, 11558.653240402802, 11580.768384632429, 11755.941220293844, 12568.0, 12655.303958282382, 12773.425195866022, 12884.549040783528, 12884.677883052624, 11475.0, 12010.159288849696, 12033.699157521132, 12521.060920431186, 12544.560940367408, 11863.406829658656, 12081.697957551132, 12373.13388062827, 12499.062570307082, 12499.562515312284, 11482.94258528702, 11849.466773995364, 11939.462724177607, 12341.0, 12360.25838449696, 9549.236061114954, 9720.416774993522, 10061.0, 10371.481425928523, 10422.322549034288, 9814.950925245328, 10175.694729158136, 10188.694339169837, 10189.235807314333, 10271.7432064199], "value": 7377.210303278835, "unit": "score"}], "name": "dromaeo_css", "value": 7000.070748946269, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 122.0, 164.0, 161.0, 113.0, 113.0, 112.0, 112.0, 147.0], "value": 127.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 109.0, 143.0, 113.0, 108.0, 106.0, 118.0, 168.0, 134.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 180.0, 185.0, 182.0, 183.0, 182.0, 182.0, 183.0, 184.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 88.0, 59.0, 60.0, 59.0, 59.0, 82.0, 57.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 64.0, 92.0, 68.0, 67.0, 67.0, 88.0, 67.0, 70.0, 88.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 90.0, 86.0, 89.0, 85.0, 89.0, 86.0, 90.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 94.0, 96.0, 95.0, 95.0, 97.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 78.0, 82.0, 84.0, 80.0, 85.0, 82.0, 82.0, 80.0], "value": 81.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 53.0, 60.0, 57.0, 59.0, 56.0, 56.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 73.0, 63.0, 73.0, 70.0, 66.0, 67.0, 65.0, 66.0, 66.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 83.0, 81.0, 80.0, 72.0, 82.0, 91.0, 97.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 145.0, 145.0, 143.0, 142.0, 139.0, 139.0, 179.0, 152.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 163.0, 161.0, 165.0, 162.0, 160.0, 161.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 66.0, 66.0, 66.0, 64.0, 62.0, 64.0, 65.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1421.1, "alertThreshold": 2.0}]} 07:11:11 INFO - Return code: 0 07:11:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:11:11 INFO - # TBPL SUCCESS # 07:11:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:11:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:11:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:11:11 INFO - 2017-02-15 07:11:11.907 screenresolution[1656:10526] starting screenresolution argv=screenresolution get 07:11:11 INFO - 2017-02-15 07:11:11.910 screenresolution[1656:10526] Display 0: 1600x1200x32@60 07:11:11 INFO - 2017-02-15 07:11:11.916 screenresolution[1657:10530] starting screenresolution argv=screenresolution list 07:11:11 INFO - Available Modes on Display 0 07:11:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:11:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:11:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:11:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:11:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:11:12 INFO - Intel Iris: 07:11:12 INFO - Chipset Model: Intel Iris 07:11:12 INFO - Type: GPU 07:11:12 INFO - Bus: Built-In 07:11:12 INFO - VRAM (Dynamic, Max): 1536 MB 07:11:12 INFO - Vendor: Intel (0x8086) 07:11:12 INFO - Device ID: 0x0a2e 07:11:12 INFO - Revision ID: 0x0009 07:11:12 INFO - Displays: 07:11:12 INFO - Display: 07:11:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:11:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:11:12 INFO - Display Serial Number: 1600x1200 60 07:11:12 INFO - Main Display: Yes 07:11:12 INFO - Mirror: Off 07:11:12 INFO - Online: Yes 07:11:12 INFO - Rotation: Supported 07:11:12 INFO - Return code: 0 07:11:12 INFO - Running post-action listener: _resource_record_post_action 07:11:12 INFO - [mozharness: 2017-02-15 15:11:12.163053Z] Finished run-tests step (success) 07:11:12 INFO - Running post-run listener: _resource_record_post_run 07:11:12 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 32562176; Write bytes: 500499456; Read time: 315; Write time: 1576 07:11:12 INFO - TinderboxPrint: CPU usage
53.5% 07:11:12 INFO - TinderboxPrint: I/O read bytes / time
32,562,176 / 315 07:11:12 INFO - TinderboxPrint: I/O write bytes / time
500,499,456 / 1,576 07:11:12 INFO - TinderboxPrint: CPU idle
2,228.7 (46.5%) 07:11:12 INFO - TinderboxPrint: CPU system
960.6 (20.0%) 07:11:12 INFO - TinderboxPrint: CPU user
1,608.4 (33.5%) 07:11:12 INFO - TinderboxPrint: Swap in / out
220,102,656 / 0 07:11:12 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 177246720; Write bytes: 177313792; Read time: 16695; Write time: 384 07:11:12 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31632384; Write bytes: 305449984; Read time: 304; Write time: 1140 07:11:12 INFO - Running post-run listener: _upload_blobber_files 07:11:12 INFO - Blob upload gear active. 07:11:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:11:12 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 07:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:11:13 INFO - (blobuploader) - INFO - Open directory for files ... 07:11:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:11:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:11:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:14 INFO - (blobuploader) - INFO - Done attempting. 07:11:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:11:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:11:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:15 INFO - (blobuploader) - INFO - Done attempting. 07:11:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:11:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:11:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:18 INFO - (blobuploader) - INFO - Done attempting. 07:11:18 INFO - (blobuploader) - INFO - Iteration through files over. 07:11:18 INFO - Return code: 0 07:11:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:11:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:11:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f95983a214b2750f37b8537c8d214702d4d93c5a3cab08fdbef81e71aecba9b85632694ae885b0403135258f40de6edca644b0bb4b5c52f55e9a17ff44e6eb53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6422488a49135faf3d5987aafda76a71607ce618da1f4d146c4dfc253b84fe082881521fd036c4a758b1f851b5bb30cb5714ebc61826a45e5211f2a3157d7583", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/863aeb21becff03e8491cb8edec5f08f330594a704bda89ac5ad57e534d6351b0337a249f60397e41309a008f804f7951471763bb28b82f0d71cecffc2fb10c8"} 07:11:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:11:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:11:18 INFO - Contents: 07:11:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f95983a214b2750f37b8537c8d214702d4d93c5a3cab08fdbef81e71aecba9b85632694ae885b0403135258f40de6edca644b0bb4b5c52f55e9a17ff44e6eb53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6422488a49135faf3d5987aafda76a71607ce618da1f4d146c4dfc253b84fe082881521fd036c4a758b1f851b5bb30cb5714ebc61826a45e5211f2a3157d7583", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/863aeb21becff03e8491cb8edec5f08f330594a704bda89ac5ad57e534d6351b0337a249f60397e41309a008f804f7951471763bb28b82f0d71cecffc2fb10c8"} 07:11:18 INFO - Running post-run listener: copy_logs_to_upload_dir 07:11:18 INFO - Copying logs to upload dir... 07:11:18 INFO - mkdir: /builds/slave/test/build/upload/logs 07:11:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.533720 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-15 07:11:18.190079) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 07:11:18.193975) ========= 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.wSIINV1s3a/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.iVJbd66Qmz/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f95983a214b2750f37b8537c8d214702d4d93c5a3cab08fdbef81e71aecba9b85632694ae885b0403135258f40de6edca644b0bb4b5c52f55e9a17ff44e6eb53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6422488a49135faf3d5987aafda76a71607ce618da1f4d146c4dfc253b84fe082881521fd036c4a758b1f851b5bb30cb5714ebc61826a45e5211f2a3157d7583", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/863aeb21becff03e8491cb8edec5f08f330594a704bda89ac5ad57e534d6351b0337a249f60397e41309a008f804f7951471763bb28b82f0d71cecffc2fb10c8"} build_url:https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010336 build_url: 'https://queue.taskcluster.net/v1/task/I18WbNjIR1iWP26e2FmV1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f95983a214b2750f37b8537c8d214702d4d93c5a3cab08fdbef81e71aecba9b85632694ae885b0403135258f40de6edca644b0bb4b5c52f55e9a17ff44e6eb53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6422488a49135faf3d5987aafda76a71607ce618da1f4d146c4dfc253b84fe082881521fd036c4a758b1f851b5bb30cb5714ebc61826a45e5211f2a3157d7583", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/863aeb21becff03e8491cb8edec5f08f330594a704bda89ac5ad57e534d6351b0337a249f60397e41309a008f804f7951471763bb28b82f0d71cecffc2fb10c8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 07:11:18.227672) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 07:11:18.227989) ========= 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.wSIINV1s3a/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.iVJbd66Qmz/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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.005122 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 07:11:18.279388) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 07:11:18.280335) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 07:11:18.281064) ========= ========= Total master_lag: 0.19 =========