builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0315 starttime: 1486765276.31 results: success (0) buildid: 20170210123454 builduid: 0a897735900642c38424569f77ecdfd7 revision: 4603dc332d7f1a384c5f4b39192e992f596a4c5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:16.307751) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:16.308227) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:16.308516) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:16.334891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:16.335204) ========= 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.SeQe1xRET8/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.nkeJCPNOzc/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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-10 14:21:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.2M=0s 2017-02-10 14:21:16 (28.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098146 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:16.457063) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:16.457386) ========= 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.SeQe1xRET8/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.nkeJCPNOzc/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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.024744 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:16.508889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-10 14:21:16.509700) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4603dc332d7f1a384c5f4b39192e992f596a4c5b --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 4603dc332d7f1a384c5f4b39192e992f596a4c5b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SeQe1xRET8/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.nkeJCPNOzc/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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-10 14:21:16,620 truncating revision to first 12 chars 2017-02-10 14:21:16,620 Setting DEBUG logging. 2017-02-10 14:21:16,620 attempt 1/10 2017-02-10 14:21:16,620 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4603dc332d7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-10 14:21:17,792 unpacking tar archive at: mozilla-beta-4603dc332d7f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.446716 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-10 14:21:18.004539) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:18.004828) ========= script_repo_revision: 4603dc332d7f1a384c5f4b39192e992f596a4c5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:18.005203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:18.005508) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:18.039104) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-10 14:21:18.039427) ========= /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.SeQe1xRET8/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.nkeJCPNOzc/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 14:21:18 INFO - MultiFileLogger online at 20170210 14:21:18 in /builds/slave/test 14:21:18 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 14:21:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:21:18 INFO - {'append_to_log': False, 14:21:18 INFO - 'base_work_dir': '/builds/slave/test', 14:21:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:21:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:21:18 INFO - 'branch': 'Mozilla-Beta', 14:21:18 INFO - 'buildbot_json_path': 'buildprops.json', 14:21:18 INFO - 'config_files': ('talos/mac_config.py',), 14:21:18 INFO - 'default_actions': ('clobber', 14:21:18 INFO - 'read-buildbot-config', 14:21:18 INFO - 'download-and-extract', 14:21:18 INFO - 'populate-webroot', 14:21:18 INFO - 'create-virtualenv', 14:21:18 INFO - 'install', 14:21:18 INFO - 'run-tests'), 14:21:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:21:18 INFO - 'download_minidump_stackwalk': True, 14:21:18 INFO - 'download_symbols': 'ondemand', 14:21:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:21:18 INFO - 'tooltool.py': '/tools/tooltool.py', 14:21:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:21:18 INFO - '/tools/misc-python/virtualenv.py')}, 14:21:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:21:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:21:18 INFO - 'installer_path': 'installer.exe', 14:21:18 INFO - 'log_level': 'info', 14:21:18 INFO - 'log_name': 'talos', 14:21:18 INFO - 'log_to_console': True, 14:21:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:21:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:21:18 INFO - 'opt_config_files': (), 14:21:18 INFO - 'pip_index': False, 14:21:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:21:18 INFO - 'cmd': ('bash', 14:21:18 INFO - '-c', 14:21:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:21:18 INFO - 'enabled': True, 14:21:18 INFO - 'halt_on_failure': False, 14:21:18 INFO - 'name': 'check_screen_resolution'},), 14:21:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:21:18 INFO - 'cmd': ('bash', 14:21:18 INFO - '-c', 14:21:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:21:18 INFO - 'enabled': True, 14:21:18 INFO - 'halt_on_failure': False, 14:21:18 INFO - 'name': 'check_screen_resolution'},), 14:21:18 INFO - 'run_cmd_checks_enabled': True, 14:21:18 INFO - 'sps_profile': False, 14:21:18 INFO - 'sps_profile_interval': 0, 14:21:18 INFO - 'suite': 'dromaeojs', 14:21:18 INFO - 'system_bits': '32', 14:21:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:21:18 INFO - 'title': 't-yosemite-r7-0315', 14:21:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:21:18 INFO - 'use_talos_json': True, 14:21:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:21:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:21:18 INFO - 'work_dir': 'build'} 14:21:18 INFO - [mozharness: 2017-02-10 22:21:18.253190Z] Running clobber step. 14:21:18 INFO - Running pre-action listener: _resource_record_pre_action 14:21:18 INFO - Running main action method: clobber 14:21:18 INFO - rmtree: /builds/slave/test/build 14:21:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:21:20 INFO - Running post-action listener: _resource_record_post_action 14:21:20 INFO - [mozharness: 2017-02-10 22:21:20.694645Z] Finished clobber step (success) 14:21:20 INFO - [mozharness: 2017-02-10 22:21:20.694810Z] Running read-buildbot-config step. 14:21:20 INFO - Running pre-action listener: _resource_record_pre_action 14:21:20 INFO - Running main action method: read_buildbot_config 14:21:20 INFO - Using buildbot properties: 14:21:20 INFO - { 14:21:20 INFO - "project": "", 14:21:20 INFO - "product": "firefox", 14:21:20 INFO - "script_repo_revision": "production", 14:21:20 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:21:20 INFO - "repository": "", 14:21:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:21:20 INFO - "buildid": "20170210123454", 14:21:20 INFO - "pgo_build": "False", 14:21:20 INFO - "basedir": "/builds/slave/test", 14:21:20 INFO - "buildnumber": 21, 14:21:20 INFO - "slavename": "t-yosemite-r7-0315", 14:21:20 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:21:20 INFO - "platform": "yosemite_r7", 14:21:20 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:21:20 INFO - "branch": "mozilla-beta", 14:21:20 INFO - "repo_path": "releases/mozilla-beta", 14:21:20 INFO - "revision": "4603dc332d7f1a384c5f4b39192e992f596a4c5b", 14:21:20 INFO - "stage_platform": "macosx64", 14:21:20 INFO - "builduid": "0a897735900642c38424569f77ecdfd7", 14:21:20 INFO - "slavebuilddir": "test" 14:21:20 INFO - } 14:21:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 14:21:20 INFO - Running post-action listener: _resource_record_post_action 14:21:20 INFO - [mozharness: 2017-02-10 22:21:20.698200Z] Finished read-buildbot-config step (success) 14:21:20 INFO - [mozharness: 2017-02-10 22:21:20.698321Z] Running download-and-extract step. 14:21:20 INFO - Running pre-action listener: _resource_record_pre_action 14:21:20 INFO - Running main action method: download_and_extract 14:21:20 INFO - mkdir: /builds/slave/test/build/tests 14:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:20 INFO - trying https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 14:21:20 INFO - Downloading https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/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 14:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/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 14:21:21 INFO - Downloaded 1165 bytes. 14:21:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 14:21:21 INFO - Using the following test package requirements: 14:21:21 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 14:21:21 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:21:21 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 14:21:21 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:21:21 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 14:21:21 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:21:21 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:21:21 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 14:21:21 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 14:21:21 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:21:21 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 14:21:21 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:21:21 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 14:21:21 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:21:21 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 14:21:21 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:21:21 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 14:21:21 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 14:21:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 14:21:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 14:21:21 INFO - Fetch https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 14:21:21 INFO - Http code: 200 14:21:21 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 14:21:21 INFO - x-amz-cf-id: S-WLdjLDsCj46YxQdnVmNyOj12pyD_mG5HTn_ONFdB3lV5kw7dlekg== 14:21:21 INFO - x-amz-version-id: 2A45HoljFu9_OXTp2GrtsCeO8F4eqTzm 14:21:22 INFO - Expected file size: 16093627 14:21:22 INFO - Obtained file size: 16093627 14:21:28 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 14:21:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 14:21:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 14:21:28 INFO - Fetch https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 14:21:29 INFO - Http code: 200 14:21:29 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 14:21:29 INFO - x-amz-cf-id: 3PlVaAFrDANIfTn0NCqqqDtPO4DlBD686JrW4WoW780iQS_RkSzfog== 14:21:29 INFO - x-amz-version-id: 2A45HoljFu9_OXTp2GrtsCeO8F4eqTzm 14:21:29 INFO - Expected file size: 16093627 14:21:29 INFO - Obtained file size: 16093627 14:21:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 14:21:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 14:21:35 INFO - Fetch https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 14:21:36 INFO - Http code: 200 14:21:36 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 14:21:36 INFO - x-amz-cf-id: u61MJ6ooQCqDVIlrcsp6JZmguGfJ56UPyLP5ZopMvds8ZiyGRUUEFg== 14:21:36 INFO - x-amz-version-id: 9U4f7XjDwOpIb2Q8wJA2bSNBeLBZSEOo 14:21:36 INFO - Expected file size: 14403005 14:21:36 INFO - Obtained file size: 14403005 14:21: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')]} 14:21:37 INFO - trying https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:21:37 INFO - Downloading https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 14:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/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 14:21:39 INFO - Downloaded 82129403 bytes. 14:21:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:21:39 INFO - mkdir: /builds/slave/test/properties 14:21:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:21:39 INFO - Writing to file /builds/slave/test/properties/build_url 14:21:39 INFO - Contents: 14:21:39 INFO - build_url:https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:21:39 INFO - Running post-action listener: _resource_record_post_action 14:21:39 INFO - Running post-action listener: set_extra_try_arguments 14:21:39 INFO - [mozharness: 2017-02-10 22:21:39.904094Z] Finished download-and-extract step (success) 14:21:39 INFO - [mozharness: 2017-02-10 22:21:39.904243Z] Running populate-webroot step. 14:21:39 INFO - Running pre-action listener: _resource_record_pre_action 14:21:39 INFO - Running main action method: populate_webroot 14:21:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:21:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:21:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:21:39 INFO - '--tppagecycles', 14:21:39 INFO - '7'], 14:21:39 INFO - 'tests': ['tsvgm']}}, 14:21:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:21:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:21:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:21:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:21:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:21:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:21:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:39 INFO - 'talos_options': ['--disable-e10s'], 14:21:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:39 INFO - 'talos_options': ['--disable-e10s'], 14:21:39 INFO - 'tests': ['damp', 'tps']}, 14:21:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:39 INFO - 'tests': ['damp', 'tps']}, 14:21:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:21:39 INFO - 'tests': ['dromaeo_dom']}, 14:21:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:21:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:21:39 INFO - 'tests': ['basic_compositor_video']}, 14:21:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:21:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:21:39 INFO - 'tests': ['a11yr', 14:21:39 INFO - 'ts_paint', 14:21:39 INFO - 'tpaint', 14:21:39 INFO - 'sessionrestore', 14:21:39 INFO - 'sessionrestore_no_auto_restore', 14:21:39 INFO - 'tabpaint']}, 14:21:39 INFO - 'other-e10s': {'tests': ['a11yr', 14:21:39 INFO - 'ts_paint', 14:21:39 INFO - 'tpaint', 14:21:39 INFO - 'sessionrestore', 14:21:39 INFO - 'sessionrestore_no_auto_restore', 14:21:39 INFO - 'tabpaint']}, 14:21:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:21:39 INFO - 'ts_paint', 14:21:39 INFO - 'tpaint', 14:21:39 INFO - 'sessionrestore', 14:21:39 INFO - 'sessionrestore_no_auto_restore', 14:21:39 INFO - 'tabpaint']}, 14:21:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:21:39 INFO - 'ts_paint', 14:21:39 INFO - 'tpaint', 14:21:39 INFO - 'sessionrestore', 14:21:39 INFO - 'sessionrestore_no_auto_restore', 14:21:39 INFO - 'tabpaint']}, 14:21:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:21:39 INFO - 'tests': ['a11yr', 14:21:39 INFO - 'ts_paint', 14:21:39 INFO - 'tpaint', 14:21:39 INFO - 'sessionrestore', 14:21:39 INFO - 'sessionrestore_no_auto_restore', 14:21:39 INFO - 'tabpaint']}, 14:21:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:21:39 INFO - 'tests': ['a11yr', 14:21:39 INFO - 'ts_paint', 14:21:39 INFO - 'tpaint', 14:21:39 INFO - 'sessionrestore', 14:21:39 INFO - 'sessionrestore_no_auto_restore', 14:21:39 INFO - 'tabpaint']}, 14:21:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:21:39 INFO - 'tests': ['tsvgx', 14:21:39 INFO - 'tsvgr_opacity', 14:21:39 INFO - 'tart', 14:21:39 INFO - 'tscrollx', 14:21:39 INFO - 'cart']}, 14:21:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:21:39 INFO - 'tsvgr_opacity', 14:21:39 INFO - 'tart', 14:21:39 INFO - 'tscrollx', 14:21:39 INFO - 'cart']}, 14:21:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:39 INFO - 'talos_options': ['--disable-e10s'], 14:21:39 INFO - 'tests': ['tp5o']}, 14:21:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:39 INFO - 'tests': ['tp5o']}, 14:21:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:39 INFO - 'talos_options': ['--disable-e10s', 14:21:39 INFO - '--xperf_path', 14:21:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:39 INFO - 'tests': ['tp5n']}, 14:21:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:39 INFO - 'talos_options': ['--xperf_path', 14:21:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:39 INFO - 'tests': ['tp5n']}}, 14:21:39 INFO - 'talos.zip': {'path': '', 14:21:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:21:39 INFO - Running post-action listener: _resource_record_post_action 14:21:39 INFO - [mozharness: 2017-02-10 22:21:39.922610Z] Finished populate-webroot step (success) 14:21:39 INFO - [mozharness: 2017-02-10 22:21:39.922741Z] Running create-virtualenv step. 14:21:39 INFO - Running pre-action listener: _resource_record_pre_action 14:21:39 INFO - Running main action method: create_virtualenv 14:21:39 INFO - Creating virtualenv /builds/slave/test/build/venv 14:21:39 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 14:21:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:21:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:21:40 INFO - Using real prefix '/tools/python27' 14:21:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:21:40 INFO - Installing distribute.............................................................................................................................................................................................done. 14:21:43 INFO - Installing pip.................done. 14:21:43 INFO - Return code: 0 14:21:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:21:43 INFO - Reading from file tmpfile_stdout 14:21:43 INFO - Output received: 14:21: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) 14:21:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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 0x10413e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a0d7dc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f52d30>, '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 0x103db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f4ab20>, '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.SeQe1xRET8/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.nkeJCPNOzc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 14:21: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 14:21: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 14:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SeQe1xRET8/Render', 14:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:43 INFO - 'HOME': '/Users/cltbld', 14:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:43 INFO - 'LOGNAME': 'cltbld', 14:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:43 INFO - 'MOZ_NO_REMOTE': '1', 14:21:43 INFO - 'NO_EM_RESTART': '1', 14:21:43 INFO - 'PAGER': '/bin/cat', 14:21:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:43 INFO - 'PWD': '/builds/slave/test', 14:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:43 INFO - 'SHELL': '/bin/bash', 14:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nkeJCPNOzc/Listeners', 14:21:43 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 14:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:43 INFO - 'USER': 'cltbld', 14:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:43 INFO - 'XPC_FLAGS': '0x0', 14:21:43 INFO - 'XPC_SERVICE_NAME': '0', 14:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21: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 14:21:44 INFO - Cleaning up... 14:21:44 INFO - Return code: 0 14:21:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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 0x10413e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a0d7dc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f52d30>, '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 0x103db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f4ab20>, '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.SeQe1xRET8/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.nkeJCPNOzc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 14:21: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 14:21: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 14:21:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SeQe1xRET8/Render', 14:21:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:44 INFO - 'HOME': '/Users/cltbld', 14:21:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:44 INFO - 'LOGNAME': 'cltbld', 14:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:44 INFO - 'MOZ_NO_REMOTE': '1', 14:21:44 INFO - 'NO_EM_RESTART': '1', 14:21:44 INFO - 'PAGER': '/bin/cat', 14:21:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:44 INFO - 'PWD': '/builds/slave/test', 14:21:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:44 INFO - 'SHELL': '/bin/bash', 14:21:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nkeJCPNOzc/Listeners', 14:21:44 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 14:21:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:44 INFO - 'USER': 'cltbld', 14:21:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:44 INFO - 'XPC_FLAGS': '0x0', 14:21:44 INFO - 'XPC_SERVICE_NAME': '0', 14:21:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:44 INFO - Downloading/unpacking psutil>=3.1.1 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:21:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:47 INFO - Installing collected packages: psutil 14:21:47 INFO - Running setup.py install for psutil 14:21:47 INFO - building 'psutil._psutil_osx' extension 14:21:47 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 14:21: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 14:21: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 14:21: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 14:21:48 INFO - building 'psutil._psutil_posix' extension 14:21: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 14:21:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:21:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:21:48 INFO - ^ 14:21:48 INFO - 1 warning generated. 14:21: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 14:21:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:49 INFO - Successfully installed psutil 14:21:49 INFO - Cleaning up... 14:21:49 INFO - Return code: 0 14:21:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10413e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a0d7dc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f52d30>, '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 0x103db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f4ab20>, '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.SeQe1xRET8/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.nkeJCPNOzc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 14:21:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:21:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SeQe1xRET8/Render', 14:21:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:49 INFO - 'HOME': '/Users/cltbld', 14:21:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:49 INFO - 'LOGNAME': 'cltbld', 14:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:49 INFO - 'MOZ_NO_REMOTE': '1', 14:21:49 INFO - 'NO_EM_RESTART': '1', 14:21:49 INFO - 'PAGER': '/bin/cat', 14:21:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:49 INFO - 'PWD': '/builds/slave/test', 14:21:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:49 INFO - 'SHELL': '/bin/bash', 14:21:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nkeJCPNOzc/Listeners', 14:21:49 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 14:21:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:49 INFO - 'USER': 'cltbld', 14:21:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:49 INFO - 'XPC_FLAGS': '0x0', 14:21:49 INFO - 'XPC_SERVICE_NAME': '0', 14:21:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:21:51 INFO - Installing collected packages: mozsystemmonitor 14:21:51 INFO - Running setup.py install for mozsystemmonitor 14:21:52 INFO - Successfully installed mozsystemmonitor 14:21:52 INFO - Cleaning up... 14:21:52 INFO - Return code: 0 14:21:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10413e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a0d7dc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f52d30>, '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 0x103db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f4ab20>, '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.SeQe1xRET8/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.nkeJCPNOzc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 14:21:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:21:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SeQe1xRET8/Render', 14:21:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:52 INFO - 'HOME': '/Users/cltbld', 14:21:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:52 INFO - 'LOGNAME': 'cltbld', 14:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:52 INFO - 'MOZ_NO_REMOTE': '1', 14:21:52 INFO - 'NO_EM_RESTART': '1', 14:21:52 INFO - 'PAGER': '/bin/cat', 14:21:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:52 INFO - 'PWD': '/builds/slave/test', 14:21:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:52 INFO - 'SHELL': '/bin/bash', 14:21:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nkeJCPNOzc/Listeners', 14:21:52 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 14:21:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:52 INFO - 'USER': 'cltbld', 14:21:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:52 INFO - 'XPC_FLAGS': '0x0', 14:21:52 INFO - 'XPC_SERVICE_NAME': '0', 14:21:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:52 INFO - Downloading/unpacking jsonschema==2.5.1 14:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:21:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21:55 INFO - Downloading functools32-3.2.3-2.tar.gz 14:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:21:55 INFO - warning: no files found matching '*.txt' 14:21:55 INFO - no previously-included directories found matching 'build' 14:21:55 INFO - no previously-included directories found matching 'dist' 14:21:55 INFO - no previously-included directories found matching '.git*' 14:21:55 INFO - Installing collected packages: jsonschema, functools32 14:21:55 INFO - Running setup.py install for functools32 14:21:55 INFO - warning: no files found matching '*.txt' 14:21:55 INFO - no previously-included directories found matching 'build' 14:21:55 INFO - no previously-included directories found matching 'dist' 14:21:55 INFO - no previously-included directories found matching '.git*' 14:21:55 INFO - Successfully installed jsonschema functools32 14:21:55 INFO - Cleaning up... 14:21:55 INFO - Return code: 0 14:21:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:21:55 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')]} 14:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:55 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')]} 14:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:55 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 0x10413e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a0d7dc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f52d30>, '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 0x103db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f4ab20>, '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.SeQe1xRET8/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.nkeJCPNOzc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 14:21:55 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 14:21:55 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 14:21:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SeQe1xRET8/Render', 14:21:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:55 INFO - 'HOME': '/Users/cltbld', 14:21:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:55 INFO - 'LOGNAME': 'cltbld', 14:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:55 INFO - 'MOZ_NO_REMOTE': '1', 14:21:55 INFO - 'NO_EM_RESTART': '1', 14:21:55 INFO - 'PAGER': '/bin/cat', 14:21:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:55 INFO - 'PWD': '/builds/slave/test', 14:21:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:55 INFO - 'SHELL': '/bin/bash', 14:21:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nkeJCPNOzc/Listeners', 14:21:55 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 14:21:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:55 INFO - 'USER': 'cltbld', 14:21:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:55 INFO - 'XPC_FLAGS': '0x0', 14:21:55 INFO - 'XPC_SERVICE_NAME': '0', 14:21:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:21:56 INFO - Cleaning up... 14:21:56 INFO - Return code: 0 14:21:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10413e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a0d7dc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f52d30>, '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 0x103db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f4ab20>, '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.SeQe1xRET8/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.nkeJCPNOzc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 14:21:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:21:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SeQe1xRET8/Render', 14:21:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:56 INFO - 'HOME': '/Users/cltbld', 14:21:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:56 INFO - 'LOGNAME': 'cltbld', 14:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:56 INFO - 'MOZ_NO_REMOTE': '1', 14:21:56 INFO - 'NO_EM_RESTART': '1', 14:21:56 INFO - 'PAGER': '/bin/cat', 14:21:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:56 INFO - 'PWD': '/builds/slave/test', 14:21:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:56 INFO - 'SHELL': '/bin/bash', 14:21:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nkeJCPNOzc/Listeners', 14:21:56 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 14:21:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:56 INFO - 'USER': 'cltbld', 14:21:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:56 INFO - 'XPC_FLAGS': '0x0', 14:21:56 INFO - 'XPC_SERVICE_NAME': '0', 14:21:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:56 INFO - Downloading/unpacking blobuploader==1.2.4 14:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:59 INFO - Downloading blobuploader-1.2.4.tar.gz 14:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:21:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:21:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:22:00 INFO - Downloading docopt-0.6.1.tar.gz 14:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:22:00 INFO - Installing collected packages: blobuploader, requests, docopt 14:22:00 INFO - Running setup.py install for blobuploader 14:22:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:22:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:22:00 INFO - Running setup.py install for requests 14:22:01 INFO - Running setup.py install for docopt 14:22:01 INFO - Successfully installed blobuploader requests docopt 14:22:01 INFO - Cleaning up... 14:22:01 INFO - Return code: 0 14:22:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10413e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a0d7dc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f52d30>, '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 0x103db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f4ab20>, '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.SeQe1xRET8/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.nkeJCPNOzc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 14:22:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:22:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SeQe1xRET8/Render', 14:22:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:01 INFO - 'HOME': '/Users/cltbld', 14:22:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:01 INFO - 'LOGNAME': 'cltbld', 14:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:01 INFO - 'MOZ_NO_REMOTE': '1', 14:22:01 INFO - 'NO_EM_RESTART': '1', 14:22:01 INFO - 'PAGER': '/bin/cat', 14:22:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:01 INFO - 'PWD': '/builds/slave/test', 14:22:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:01 INFO - 'SHELL': '/bin/bash', 14:22:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nkeJCPNOzc/Listeners', 14:22:01 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 14:22:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:01 INFO - 'USER': 'cltbld', 14:22:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:01 INFO - 'XPC_FLAGS': '0x0', 14:22:01 INFO - 'XPC_SERVICE_NAME': '0', 14:22:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:01 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-alJ22L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:01 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-K8xYzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:01 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Xx8B1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:01 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Ocipwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:02 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-HDe956-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:02 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-ThvKcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:02 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-kmdwUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:02 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-6oEkVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:02 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-mRuV_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:02 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-cKK98O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:02 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-KjPkrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:02 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-UYSvtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:02 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-6WK0ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:02 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-5KXTf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:03 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-i63dyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:03 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-SKeKok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:03 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-b5fCoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:22:03 INFO - Running setup.py install for manifestparser 14:22:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:22:03 INFO - Running setup.py install for mozcrash 14:22:03 INFO - Running setup.py install for mozdebug 14:22:03 INFO - Running setup.py install for mozdevice 14:22:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:22:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Running setup.py install for mozfile 14:22:04 INFO - Running setup.py install for mozhttpd 14:22:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Running setup.py install for mozinfo 14:22:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Running setup.py install for mozInstall 14:22:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Running setup.py install for mozleak 14:22:04 INFO - Running setup.py install for mozlog 14:22:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Running setup.py install for moznetwork 14:22:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:22:05 INFO - Running setup.py install for mozprocess 14:22:05 INFO - Running setup.py install for mozprofile 14:22:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:22:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:22:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:22:05 INFO - Running setup.py install for mozrunner 14:22:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:22:05 INFO - Running setup.py install for mozscreenshot 14:22:05 INFO - Running setup.py install for moztest 14:22:05 INFO - Running setup.py install for mozversion 14:22:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:22:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:22:05 INFO - Cleaning up... 14:22:06 INFO - Return code: 0 14:22:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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')]} 14:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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 0x10413e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a0d7dc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f52d30>, '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 0x103db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f4ab20>, '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.SeQe1xRET8/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.nkeJCPNOzc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 14:22: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 14:22: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 14:22:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SeQe1xRET8/Render', 14:22:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:06 INFO - 'HOME': '/Users/cltbld', 14:22:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:06 INFO - 'LOGNAME': 'cltbld', 14:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:06 INFO - 'MOZ_NO_REMOTE': '1', 14:22:06 INFO - 'NO_EM_RESTART': '1', 14:22:06 INFO - 'PAGER': '/bin/cat', 14:22:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:06 INFO - 'PWD': '/builds/slave/test', 14:22:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:06 INFO - 'SHELL': '/bin/bash', 14:22:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nkeJCPNOzc/Listeners', 14:22:06 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 14:22:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:06 INFO - 'USER': 'cltbld', 14:22:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:06 INFO - 'XPC_FLAGS': '0x0', 14:22:06 INFO - 'XPC_SERVICE_NAME': '0', 14:22:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:07 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-VQYznd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22: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)) 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:07 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Bg_88_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22: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)) 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:07 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-rUgEHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22: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)) 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:07 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-kB9_4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22: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)) 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:07 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-JNzsHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22: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)) 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:07 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-16nWN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22: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)) 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:07 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-1K9X5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22: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)) 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:07 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-jRZFNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22: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)) 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:07 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-jImIpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:08 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)) 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:08 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-8Wioyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22: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)) 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:08 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-4mUURZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22: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)) 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:08 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-WhBbJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22: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)) 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:08 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-O20POe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22: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)) 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:08 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-cmevAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22: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)) 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:08 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-nrksn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22: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)) 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:08 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-cYK_SU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22: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)) 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:08 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-oZ_YmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22: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)) 14:22: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)) 14:22: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)) 14:22: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)) 14:22: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)) 14:22: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)) 14:22:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22:11 INFO - Downloading blessings-1.6.tar.gz 14:22:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:22:12 INFO - Installing collected packages: blessings 14:22:12 INFO - Running setup.py install for blessings 14:22:12 INFO - Successfully installed blessings 14:22:12 INFO - Cleaning up... 14:22:12 INFO - Return code: 0 14:22:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:22:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:12 INFO - Reading from file tmpfile_stdout 14:22:12 INFO - Current package versions: 14:22:12 INFO - blessings == 1.6 14:22:12 INFO - blobuploader == 1.2.4 14:22:12 INFO - docopt == 0.6.1 14:22:12 INFO - functools32 == 3.2.3-2 14:22:12 INFO - jsonschema == 2.5.1 14:22:12 INFO - manifestparser == 1.1 14:22:12 INFO - mozInstall == 1.12 14:22:12 INFO - mozcrash == 1.0 14:22:12 INFO - mozdebug == 0.1 14:22:12 INFO - mozdevice == 0.48 14:22:12 INFO - mozfile == 1.2 14:22:12 INFO - mozhttpd == 0.7 14:22:12 INFO - mozinfo == 0.9 14:22:12 INFO - mozleak == 0.1 14:22:12 INFO - mozlog == 3.4 14:22:12 INFO - moznetwork == 0.27 14:22:12 INFO - mozprocess == 0.23 14:22:12 INFO - mozprofile == 0.28 14:22:12 INFO - mozrunner == 6.13 14:22:12 INFO - mozscreenshot == 0.1 14:22:12 INFO - mozsystemmonitor == 0.3 14:22:12 INFO - moztest == 0.8 14:22:12 INFO - mozversion == 1.4 14:22:12 INFO - psutil == 3.1.1 14:22:12 INFO - requests == 1.2.3 14:22:12 INFO - wsgiref == 0.1.2 14:22:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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')]} 14:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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 0x10413e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a0d7dc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f52d30>, '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 0x103db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f4ab20>, '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.SeQe1xRET8/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.nkeJCPNOzc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 14:22: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 14:22: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 14:22:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SeQe1xRET8/Render', 14:22:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:12 INFO - 'HOME': '/Users/cltbld', 14:22:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:12 INFO - 'LOGNAME': 'cltbld', 14:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:12 INFO - 'MOZ_NO_REMOTE': '1', 14:22:12 INFO - 'NO_EM_RESTART': '1', 14:22:12 INFO - 'PAGER': '/bin/cat', 14:22:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:12 INFO - 'PWD': '/builds/slave/test', 14:22:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:12 INFO - 'SHELL': '/bin/bash', 14:22:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nkeJCPNOzc/Listeners', 14:22:12 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 14:22:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:12 INFO - 'USER': 'cltbld', 14:22:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:12 INFO - 'XPC_FLAGS': '0x0', 14:22:12 INFO - 'XPC_SERVICE_NAME': '0', 14:22:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22: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)) 14:22: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)) 14:22: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)) 14:22: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)) 14:22: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)) 14:22: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)) 14:22: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)) 14:22: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)) 14:22: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)) 14:22: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)) 14:22: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)) 14:22:12 INFO - Cleaning up... 14:22:12 INFO - Return code: 0 14:22:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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')]} 14:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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 0x10413e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a0d7dc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f52d30>, '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 0x103db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f4ab20>, '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.SeQe1xRET8/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.nkeJCPNOzc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 14:22: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 14:22: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 14:22:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SeQe1xRET8/Render', 14:22:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:12 INFO - 'HOME': '/Users/cltbld', 14:22:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:12 INFO - 'LOGNAME': 'cltbld', 14:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:12 INFO - 'MOZ_NO_REMOTE': '1', 14:22:12 INFO - 'NO_EM_RESTART': '1', 14:22:12 INFO - 'PAGER': '/bin/cat', 14:22:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:12 INFO - 'PWD': '/builds/slave/test', 14:22:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:12 INFO - 'SHELL': '/bin/bash', 14:22:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nkeJCPNOzc/Listeners', 14:22:12 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 14:22:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:12 INFO - 'USER': 'cltbld', 14:22:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:12 INFO - 'XPC_FLAGS': '0x0', 14:22:12 INFO - 'XPC_SERVICE_NAME': '0', 14:22:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:22:13 INFO - Cleaning up... 14:22:13 INFO - Return code: 0 14:22:13 INFO - Running post-action listener: _resource_record_post_action 14:22:13 INFO - Running post-action listener: _start_resource_monitoring 14:22:13 INFO - Starting resource monitoring. 14:22:13 INFO - [mozharness: 2017-02-10 22:22:13.139403Z] Finished create-virtualenv step (success) 14:22:13 INFO - [mozharness: 2017-02-10 22:22:13.140421Z] Running install step. 14:22:13 INFO - Running pre-action listener: _resource_record_pre_action 14:22:13 INFO - Running main action method: install 14:22:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:13 INFO - Reading from file tmpfile_stdout 14:22:13 INFO - Detecting whether we're running mozinstall >=1.0... 14:22:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:22:13 INFO - Reading from file tmpfile_stdout 14:22:13 INFO - Output received: 14:22:13 INFO - Usage: mozinstall [options] installer 14:22:13 INFO - Options: 14:22:13 INFO - -h, --help show this help message and exit 14:22:13 INFO - -d DEST, --destination=DEST 14:22:13 INFO - Directory to install application into. [default: 14:22:13 INFO - "/builds/slave/test"] 14:22:13 INFO - --app=APP Application being installed. [default: firefox] 14:22:13 INFO - mkdir: /builds/slave/test/build/application 14:22:13 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'] 14:22:13 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 14:22:34 INFO - Reading from file tmpfile_stdout 14:22:34 INFO - Output received: 14:22:34 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:22:34 INFO - Running post-action listener: _resource_record_post_action 14:22:34 INFO - [mozharness: 2017-02-10 22:22:34.853749Z] Finished install step (success) 14:22:34 INFO - [mozharness: 2017-02-10 22:22:34.853881Z] Running run-tests step. 14:22:34 INFO - Running pre-action listener: _resource_record_pre_action 14:22:34 INFO - Running main action method: run_tests 14:22:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:22:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:22:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:22:34 INFO - 2017-02-10 14:22:34.868 screenresolution[1627:7339] starting screenresolution argv=screenresolution get 14:22:34 INFO - 2017-02-10 14:22:34.870 screenresolution[1627:7339] Display 0: 1600x1200x32@60 14:22:34 INFO - 2017-02-10 14:22:34.876 screenresolution[1628:7341] starting screenresolution argv=screenresolution list 14:22:34 INFO - Available Modes on Display 0 14:22:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:22:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:22:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:22:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:22:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:22:35 INFO - Intel Iris: 14:22:35 INFO - Chipset Model: Intel Iris 14:22:35 INFO - Type: GPU 14:22:35 INFO - Bus: Built-In 14:22:35 INFO - VRAM (Dynamic, Max): 1536 MB 14:22:35 INFO - Vendor: Intel (0x8086) 14:22:35 INFO - Device ID: 0x0a2e 14:22:35 INFO - Revision ID: 0x0009 14:22:35 INFO - Displays: 14:22:35 INFO - Display: 14:22:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:22:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:22:35 INFO - Display Serial Number: 1600x1200 60 14:22:35 INFO - Main Display: Yes 14:22:35 INFO - Mirror: Off 14:22:35 INFO - Online: Yes 14:22:35 INFO - Rotation: Supported 14:22:35 INFO - Return code: 0 14:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:22:35 INFO - Python 2.7.3 14:22:35 INFO - Return code: 0 14:22:35 INFO - grabbing minidump binary from tooltool 14:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:35 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 0x103f52d30>, '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 0x103db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f4ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:22:35 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 14:22:35 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 14:22:35 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 14:22:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:22:35 INFO - Return code: 0 14:22:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:22:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:22:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:22:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:22:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:22:35 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/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0315', '--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 14:22:35 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/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0315 --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 14:22:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SeQe1xRET8/Render', 14:22:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:35 INFO - 'HOME': '/Users/cltbld', 14:22:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:35 INFO - 'LOGNAME': 'cltbld', 14:22:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:22:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:35 INFO - 'MOZ_NO_REMOTE': '1', 14:22:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:22:35 INFO - 'NO_EM_RESTART': '1', 14:22:35 INFO - 'PAGER': '/bin/cat', 14:22:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:35 INFO - 'PWD': '/builds/slave/test', 14:22:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:22:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:35 INFO - 'SHELL': '/bin/bash', 14:22:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nkeJCPNOzc/Listeners', 14:22:35 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 14:22:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:35 INFO - 'USER': 'cltbld', 14:22:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:35 INFO - 'XPC_FLAGS': '0x0', 14:22:35 INFO - 'XPC_SERVICE_NAME': '0', 14:22:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:35 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/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0315', '--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 14:22:35 INFO - mozversion application_buildid: 20170210123454 14:22:35 INFO - mozversion application_changeset: 4603dc332d7f1a384c5f4b39192e992f596a4c5b 14:22:35 INFO - mozversion application_display_name: Firefox 14:22:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:22:35 INFO - mozversion application_name: Firefox 14:22:35 INFO - mozversion application_remotingname: firefox 14:22:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:22:35 INFO - mozversion application_vendor: Mozilla 14:22:35 INFO - mozversion application_version: 52.0 14:22:35 INFO - mozversion platform_buildid: 20170210123454 14:22:35 INFO - mozversion platform_changeset: 4603dc332d7f1a384c5f4b39192e992f596a4c5b 14:22:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:22:35 INFO - mozversion platform_version: 52.0 14:22:35 INFO - using testdate: 1486765355 14:22:35 INFO - actual date: 1486765355 14:22:35 INFO - starting webserver on 'localhost:49241' 14:22:35 INFO - SUITE-START | Running 2 tests 14:22:35 INFO - TEST-START | dromaeo_css 14:22:35 INFO - operating with platform_type : mac_ 14:22:35 INFO - Initialising browser for dromaeo_css test... 14:22:35 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmp0u0Uvm/profile http://localhost:49241/getInfo.html) 14:22:38 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 14:22:38 INFO - PROCESS | 1638 | colorDepth:24 14:22:38 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 14:22:38 INFO - PROCESS | 1638 | __metrics 14:22:38 INFO - PROCESS | 1638 | 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" 14:22:38 INFO - PROCESS | 1638 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:22:39 INFO - TEST-INFO | 1638: exit 0 14:22:39 INFO - Browser initialized. 14:22:39 INFO - Running cycle 1/1 for dromaeo_css test... 14:22:39 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmp0u0Uvm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:51 INFO - PROCESS | 1641 | RSS: Main: 167682048 14:22:51 INFO - PROCESS | 1641 | 14:25:54 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 14:25:55 INFO - PROCESS | 1641 | RSS: Main: 277004288 14:25:55 INFO - PROCESS | 1641 | 14:28:58 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 14:28:58 INFO - PROCESS | 1641 | RSS: Main: 296009728 14:28:58 INFO - PROCESS | 1641 | 14:32:01 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 14:32:01 INFO - PROCESS | 1641 | RSS: Main: 280174592 14:32:01 INFO - PROCESS | 1641 | 14:35:04 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 14:35:04 INFO - PROCESS | 1641 | RSS: Main: 261210112 14:35:04 INFO - PROCESS | 1641 | 14:38:07 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 14:38:08 INFO - PROCESS | 1641 | RSS: Main: 254881792 14:38:08 INFO - PROCESS | 1641 | 14:41:11 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 14:41:11 INFO - PROCESS | 1641 | RSS: Main: 344707072 14:41:11 INFO - PROCESS | 1641 | 14:41:11 INFO - PROCESS | 1641 | __start_tp_report 14:41:11 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 14:41:11 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 14:41:11 INFO - PROCESS | 1641 | |i|pagename|runs| 14:41:11 INFO - PROCESS | 1641 | |0;dojo.html;2919.69343218962;3493.4934434507004;3515.859365625375;3544.85820567177;3576.2311103112825;5736.053551164053;5744.856378590527;5745.597808153426;5761.4814666679995;5805.825825225239;4543.432070991126;5755.740991655375;5846.123081537761;5853.853653658661;5864.208331875196;5260.631755777097;5270.578353731692;5275.446078161785;5296.947030529704;5332.760025798849;4209.663226941852;4859.368282123319;5202.089634313998;5355.0896347621;5368.382635996852;4848.927266091011;5243.816466423676;5304.230886521452;5313.309269794921;5317.9468205318035;5270.446603106657;5293.311869456946;5296.761645725913;5305.708186049766;5353.518183363516;5176.896462070775;5276.182191760283;5284.260203571503;5286.3392075990505;5297.020051290524;5679.176519404663;5696.401877802854;5722.341930677983;5737.799177028825;5832.358440571534;6228.34602366754;6261.906071408933;6293.992961126243;6303.684815759194;6340.270868850049;5239.607029472767;6274.349597951392;6284.5600807943465;6306.779262725782;6310.337414571496;5753.568482363756;5798;5828.941710582924;5926.7925622603;5970.641761494324;6275.121482992385;6286.402791734778;6315.210598675166;6328.050792381087;6335.524835637346;6259.374062593704;6265.8120256392385;6286.591371560926;6294.433500984934;6297.118403423525;6207.224096987877;6249;6288.276848162428;6334.588251763621;6341.714622841983;6288.119663247149;6346.333634968354;6346.714397852108;6349.365063493614;6352.968235158794;6312.380362149656;6352.333005034498;6355.396237357444;6371.139896114058;6375.521835862329;4909.042736666316;4966.478519755374;4993.7503124843615;5004.07424626438;5044.319016932741;3829.195868867513;4480.686351955332;4511.819527218874;4514.6388288936805;4525.841595544141;4848.757562121879;5914.231149950565;5925.4074592541265;5933.554983376264;5938.940610593925;6247.250329960434;6289;6298.842528936813;6302.590331628429;6311.715972781236;5694.117411801178;5718.628289161191;5814.447627475383;5845.298564172242;5854.8536286592325;5506.449355064461;5530.944690553123;5542.307211598551;5548.611597188158;5557.972210138923;6387.265464471645;6399.200099987502;6400.327965563642;6415.294317624965;6416.486681065504;6189.442950134509;6238.625682459067;6293.905591416224;6311.431971122621;6312.5581209314905;5069.6197785167;6396.456301214263;6400.775972840928;6402.071699603624;6411.6794160290865;6184.783532576338;6224.719887604978;6351.96824015877;6383.808485745435;6386.489080873612;4790.664653474223;6187.597806142587;6210.534209934363;6265.498760099273;6266.749330026748;6202.2867370253;6202.658853763086;6210.130581718473;6224.564280500503;6246.750129994749;5830.82507524775;6155.907661384993;6161.260648722182;6170.136180934583;6187.535934804998;5844.970775146097;5948.613340132878;5965.254343207099;5972.761089556369;6040.577159598962;6164.660943648142;6181.938180618136;6234.220722409699;6248.156498872776;6265.279492858197;6081.665508397081;6093.969530152321;6099.146119543356;6103.572749907464;6116.5718399711595 14:41:11 INFO - PROCESS | 1641 | |1;ext.html;478.2372116474223;485.8761015940934;501.43087595579004;527.0855066459694;541.4991133201788;26205.606915896253;33362.66549338029;33390;33390.83304583477;41563.79218103913;41446;44149.77925110378;44236.77881610596;44335.55664443355;44402;9564.995675454064;9689.806203875918;9716.174125199366;9739.561719722595;9751.90248097517;8954.37319387643;9209.95395023024;9566.186874115674;9664.323497355188;9684.903150968506;11484.425778711073;11727.648170554854;11784.7643047139;11965.341906195155;11976.820347694791;9466.574004169828;11740.765184696302;11822.704432389173;11843.111766617452;11865.52537898483;11732.413379331;11805.350705711267;11819.468123934357;11820.645380638594;11829.763404731857;41452.79273603643;41775.7911210445;41849;41872.581274187476;41907.37138942918;3207.294395233045;3367.461206206995;3519.1729943463265;3661.121330880596;4008.579099194572;30212.8489357554;30468.84765576158;30854.84572577145;31753.523697144563;32382;3269.673032696735;3282.179455136216;3325.4679251319913;3346.8995930122137;3407.778494397881;502229;505577;506656.46671766776;507772;507924;34425.483617745755;34672.133196670286;64274.39314017187;64835.67582162059;65027;36544.08639784026;36615.816920915226;36738.89783306505;36845;36885;15249.085054896741;15461.38154473831;15469.303881325368;15481.83886208539;15522.767158492632;12967.027472939568;13042.087053906136;13071;13071.281079540717;13088.411021504055;7580.772576822704;7625.275598818214;7918.722844700523;7951.125376208613;8029.317508011768;2911.8398488082935;3340.866365345359;3376.848041838123;3417.1457135716073;3440.9827950860085;917.6421195733669;1002.2633364477103;1063.9734006649742;1089.743910181107;1124.6457365929707;30459.695403046127;30462.84768576143;30469.592301241828;30959.69040309568;31225.8438707805;1115.1134847796022;1119.7032786311634;1128.373752567333;1165.551262763842;1178.6640807369859;15852.44516441919;15907.681846363008;16036.919815401081;16316.694664427056;16481.917590411973;684323;688642;690538;692695;692998;60770.392296077356;60994.39005609976;61121.69439152776;61344.69327653333;61354;1180.8346831443775;1266.5756971414496;1299.551654679153;1393.2754967416886;1417.2701058954647;29785.5532167022;30911.381772363977;31688.366232674758;31937.041888743373;32211.838940806083;51355;51763.22355164751;51902.48097518976;51909.221361680364;51960.480395197075;555666;558140;559099;559528;560168;24449.511009779348;24620.630690540016;26247;26648.60027099556;26866.731332686424;47723.5227647733;47757.283640744725;47813;48142.75928620334;48342.27486587774;38661.80669096749;38909.6109038906;39640;39775;41027;38780.41829372505;39172.41241381439;39235;40303.3954490677;40531.59468405278;38345.80827095846;38394.80802595969;38983.805080974416;39130.6086939127;39464.81605551838;27930.581041284804;32544.186395340304;34560;34771.30457390787;34854.12864678403;25652.743472565035;25877.223683289532;25990.480190396465;26069.565821535398;26358.604620930317 14:41:11 INFO - PROCESS | 1641 | |2;jquery.html;380.46354639957667;382.298482285007;387.3872133238018;395.92477429288425;405.6308759029284;13751.862481375183;19997.300094496695;20237.291694790685;20721.274755383565;20747.688784668222;15725.92137039316;16970.83029169708;19613.41159765206;20083.598328033466;20088.899555502237;5890.823275301748;6068.908966365508;6110.236220472441;6112.327643959161;6127.846803829918;5755.740991655364;5964.79123230687;6028.63828170309;6054.606450580698;6055.061465472837;6122.448979591836;6132.141500189977;6132.325444201157;6137.048757442603;6148.538859585549;5830.854228644296;5991.071383935475;6074.271087469532;6077.4226448487325;6084.878302433971;5889.911651325234;5898.026825573776;5900.822975310747;5927.37762534932;5932.3177834548715;13298.534551290755;13504.864951350459;23254.30237092873;23685.526289474285;24686.13598524061;2156.212982261479;2205.3935167828977;2266.8866556672265;2269.8524595901213;2299.965500517477;9778.022197780165;9857.654982075665;10040.748981275454;10188.64358646621;10256.33333833306;1477.3868844429655;1719.8305152496298;1853.406909788868;1872;1890.933817316401;111035;125034;128577.35711321383;129950.3502482491;133087.33456332755;9143.94844592867;9382;9658.468784216795;10806.459677016117;11822.280875398706;15219.543413697607;15220;15243.847561524464;15245.313960871566;15284.617884552752;7802.687892484237;8188.058373287148;8228.465149765367;8413.200745929127;8524.104968978168;8675.305975521944;8733.34499912509;8794.95602521996;8843.248323892412;8900.486917223958;4183.91632167355;4608.078384323148;4682.531746825291;4688.156131896291;4750.976245118753;1539.6074001129864;1788.8694784127777;1796.3712700554702;1840.723512148378;1935.8064193580528;376.6911132871019;387.2429400521973;395.29637245702696;407.83278855669624;821.8068753842842;9742.756431089138;11585.826212606818;11649;11675.241109327866;12028;419.6642685851307;428.08390045303076;433.79177994562787;444.8776586438755;446.68062335429676;5291.470852914677;5762.1068734346245;5950.494207992283;6002.069679199643;6101.938980610226;618758;621333;630247;644522;648431;138851;141482;144747.276263618;145444;145583;446.4174252600388;981.7251169672503;1036.5180191211123;1050.4642632257603;1051.453244312953;16963.915180424017;18871.05644717731;19522.90238548798;19828;20315.796842031392;56707.716461417425;57918.71040644938;58118;59223;60693;82357.17642823495;83093;85369.57315213385;85599.5720021396;89205.66191507003;7880.960595196987;7997.0078543822465;8074.919250807417;8336.416450848625;8340.541270230196;11938.462769175234;12442.937785311016;12864.22814631125;12890.355482225663;13148.80276795868;10931.01620854127;11144.2199046066;11228.101751859995;11449.026832719312;11595;10828.891711082788;10971.50628221716;11136.55453781872;11395.601153959571;11449.313041217554;11393.886061139614;11461.083113351078;11692.88307116952;11793.52825886955;11810.881891181321;8215.671373145007;8468.872966905625;8474.406791524534;8514.74455766328;8612.224899758801;9154.359194856295;9289;10926.836097458703;10990.505427255952;11182.384968826793 14:41:11 INFO - PROCESS | 1641 | |3;mootools.html;1505.9247037648122;1531.6062383231258;1712.1011468978784;1803.440933310673;1871.6350311689218;7242.420606351492;8547.871781923268;8553.700620478285;8559.78600534986;8566.528840913763;7536.849263014737;7819.530828150315;8181.877271840927;8338.416310858242;8355.37334699897;2362.881855907202;2394.281715485356;2400.099962514057;2400.5078958813488;2401.0875867170453;2378.63131214662;2382.880855957204;2430.2830664953794;2438.6463962725393;2445.6331550267423;2360.091364824538;2364.137089962169;2384.6899903012672;2386.0336563691644;2388.916387926423;2312.7571604981404;2314.271004633535;2337.6026075567192;2345.2377977157494;2353.3293011491814;2375.121205154087;2385.296337580418;2406.0255596483453;2409.024345140221;2418.709754829414;8370.958145209295;8456.915430845736;8458.957705211496;8459.323254139654;8468.407211495198;5043.193089105762;5195.246689230078;5198.506141916512;5199.0381779370555;5205.609579281569;3439.226174110805;3474.878379256739;3488.8255587220538;3566.857325706969;3592.568891733009;1077.4000609095488;1078.654830454255;1101.2841652925583;1115.2026301194603;1119.6361182615601;11031;11119.499622517005;11126.777464450666;11138.053265472445;11172.050375718074;3883.76697398157;4290.6269993601745;4455.509893911667;4718.3158442025715;4722.079194557097;8520.360972927056;9568.712938611852;9586.760330991781;9588.808223835484;9595.376300540442;5259.447757985433;5268.446813084571;5269.4730526947;5273.973630131824;5283.339582552181;4112.506499220053;4390.495093064274;4491.146682130385;4861.076395484846;4864.197407427735;3848.249046683752;3853.460515527828;3948.506436695413;3981.820818063194;3986.9202615948097;1278.9296588687712;1295.3393769177599;1296.4425297122327;1305.3995162225483;1313.2645718397728;740.9110906691124;840.4117118017413;890.2610833008716;901.1124042817819;902.1700035966926;5339.893202136013;5536.557075433956;5554.583406244547;5731.111677689964;5935.961206788881;966.9564869580886;970.631160159135;1002.3033991376069;1006.7483129217695;1030.9742256443499;3496.5804103507235;3518.5601799775027;3545.7163426925786;3671.2657468506404;3729.4734215123535;9836.704898853046;10355;10357.482125893675;10357.63748268807;10359.378437293786;9528;10245.590176392861;10252.128569071712;10257.435841028815;10277.280590358752;7651.885221721679;7961.243681850215;7975.441719079725;7993.200679931961;8054.23484768946;5217.530422262014;5456.399796022513;5465.207544905887;5476.342838859362;5667.2632557768875;9014.008459069628;9199.724008279762;9412.576434060347;9432.198263147435;9477.241820654193;9507.001764814595;9527;9547.809043819223;9570.808583828146;9609.615615375307;5412.7564259607625;6892.896606551006;7056;7125.394341480825;7283.490155689263;7934.246246606564;8129.959350203211;8140.75577732669;8145.307648849915;8151.79620509492;7072.9646351767915;7188.317109874553;7205.855882882208;7235.565866048054;7332.596707180943;7020.964895175695;7036.472264580075;7086.822829429306;7168.319009694071;7220.963895180701;6687.732490700318;6689.09697190873;6759.222689390586;6761.966190169018;6774.559653622696;4659.860204193879;4673.369095172108;4709.058188362273;4723.456802467623;4753.168195565693;4621.768911554342;4658.930116048195;4684.367610372556;4861.052094841472;4921.680090794087 14:41:11 INFO - PROCESS | 1641 | |4;prototype.html;273.9657542807149;290.7354307580102;313.2919601700158;317.90939582219073;321.36851087612837;4526.932096018558;5440.836774896755;5449.972750136254;5467.644603100795;5579.9163012554845;5142.871428214287;5262.526372626463;5355.758990845412;5369.476346117328;5517.36550296716;4123.299039163335;4144.399062135996;4149.070682132823;4165.520965089023;4186.204621121992;4155.92203898051;4165.291900376943;4168.583141685837;4170.165966806636;4229.477388140267;3428;3845.6731177849915;4025.0339918419663;4083.3874918762276;4174.394712766662;4115.629593336614;4142.813573389205;4162.729422587552;4169.603887630686;4175.202614248446;2860.4994126027864;3144.3868445653106;3608.765430247052;3622.2755448910325;3627.292677927805;4643.349931009661;5148.407933087706;5302.602304827154;5337.626366154371;5349.224362467459;3839.2513459875336;4152.107296931144;4403.339499075132;4686.851721328297;4723.5984941279685;5580.074874168446;5647.237622920894;5672.574556908207;5685.232493613392;5715.342735585419;3369.444041733111;3892.3188442022815;4032.254033003874;4041.4336896070913;4044.8382064717375;5219.582433405319;5233.712145831978;5563.582731295169;5890.698371465673;5952.107183922403;3429.5027221053306;3432.6910578048096;4040.939385909214;4066.898327541835;4091.8772436826944;4132.5454200037975;4136.152088821785;4155.667546596265;4201.264778663722;4208.894777630584;4480.596746292849;4749.24012158053;4784.449788274393;4811.374521312207;4824.769683730627;4801;4892.624089378318;5328.227407025959;5582.106862901916;5762.4525670061275;1171.8652354979286;1312.7308901675133;1381.9773367707824;1389.6595334142999;1395.7278330725615;900.7658008917729;920.7467946314817;932.3753085432776;935.7707361696428;948.3029972969862;4338.370936214231;4485.282354823213;4515.164694531522;4972.65191436596;5103.668261562986;4509.7970591323465;4876.536729010809;5344.305240318734;5351.143816989263;5658.321001479767;4366.607005369532;4944.901101978012;5020.849374518771;5090.567301779391;5375.408705042442;2532.696076470835;2743.7804975602303;2757.4485102979083;2795.8602069896424;2921.561765735114;5450.591205659592;5534.695591742412;5809.767609295581;5817.592768506249;5830.416958304136;5428.267183930119;5741.712914354349;5749.936261791582;5751.568632352591;5756.539476841843;4786.444405568204;5187.377514698261;5512.80705175317;5638.588653864435;5845.707714614167;4818.397700287464;5269.947300526946;5556.471970208225;5686.829395117988;5730.426957304237;5113.795448182031;5261.289725886956;5459.890802183854;5492.336216934704;5555.194496798023;4860.719014665157;5799.4780469757925;5803.82588522345;5805.274340707411;5850.414958504286;3344.565206523234;3438.3639026780124;3514.6309637488716;3555.4311310190246;3663.377225871555;4895.37032412714;5040.949590504195;5119.052975199451;5594.888102238014;5600.4959553640365;4489.842855500042;4941.023590563803;5280.049591073644;5336.706481143575;5401.837944861661;4736.644751643572;4756.9762151189025;5222.55608273301;5309.123994540858;5459.235707001102;4662.836800711959;4989.700617962933;5407;5453.673259311896;5537.446255374431;5291.947080529146;5327.733613319241;5681.573881958952;5750.827475175752;5786.9131963019745;5195.220716892345;5419.3225846769155;5564.721763911869;5656.519195868233;5793.478586927196 14:41:11 INFO - PROCESS | 1641 | |5;yui.html;691.4053913634275;738.6749830074764;765.6095391350414;779.9727009554663;828.5484410996008;14042.157470551761;14839.925800370984;14858.405663773436;14942.626434339134;15010.624734381647;13347.132436391628;13491.797623035662;13495.59513214605;13500.527481538149;13507.12203706761;712.5866997141671;717.2468907646963;735.0187499687896;849.6261644876234;881.2685471059037;859.6948083430386;869.2784988459564;873.6243415331405;880.2649787427506;882.1531329923249;922.7462447826834;923.0538697834706;923.2291036984093;923.8983711791698;925.7546750111226;911.9831388002395;916.7478943290582;918.1782304837167;919.1865199298635;919.8620206969008;680.8706345794333;681.1247546902256;682.0383259603934;682.0928165539821;682.7200847652439;13477.595672129852;13656.04407691462;13660.112092714042;13671.658208544766;14226.502072427518;13748.307443252483;14054.437822487089;14054.478888933056;14245.857541424557;14306.713865722731;11313.377764222965;11424.942875285653;11466.312021278667;11643.01034412076;11680.357580333079;3796.5960526903027;3817.408301713239;3858.189780146173;3896.0259935016247;3943;89062;92773;92809;96116;97547.02452975522;10297.3821570706;10546;10787.892121078845;10864.130869530418;10869.510872010778;20898.686519702216;21245.78754212469;21410.03654835536;21485.355439336843;21494.14023439045;7377.225391333833;7428.9628551856895;7766.339861111869;7801;7988.760337189894;4305.203537345601;4411.558844115562;4468.419105516262;4485.506594274627;4616.6537509686905;2836.290927268183;3147.213196700825;3256.3650088232566;3256.788308759923;3361.09250502363;627.9780207692709;628.707650942314;657.8552718401944;671.9529632925746;699.9370056694922;576.5618130221062;638.5976834594176;650.2554575011585;651.280335229574;654.8722999015241;8720.738377848675;8809.33929955256;9064.954675226714;9133.40632858862;9176.403533770284;512.4951922356476;564.9180868774005;612.5865041097242;659.3011407907633;668.4351722794231;4189.539150693421;4445.866624001285;4489.281714925596;4523.095380923828;4575.405197324327;81105;111052.88947110425;111065.88934110718;111971.44014279876;118397;98478;102060.48969755252;103046.48476757568;104096;109422.45288773664;66682.66658666676;84445.99999999878;85561.14438855657;87862.56068719615;89146;8187.754367368989;8389.790255243424;8665.306775457822;8667.696630617898;8782.209601135928;58576;59369.40630593639;60132.69933650479;60156;61671.383286166565;76176;84971.30057398941;85768;87239;87804.24391512261;10068.748281293027;11292.830607540729;11354.318740875575;11646.941765291458;11788.056955443373;10958.835617465586;12470.875291246972;12748.171368860994;12844.614661560168;13158.60524184276;11242.66272011841;11546.249493782878;11862.584809531625;12075;12342.81485777732;11207.551697931991;11676.766464670489;11854.348010859485;12363.454568178977;12485.93757031209;11168.944155279172;11313.547458101913;12152.331621760888;12171;12589.87410125887;9752.414855108716;9930.751731206778;9947.154491868272;10037.949810250902;10050.547725352231;9806.65676701312;9874;9882.555285012335;9888.208943284664;9905.554250058909 14:41:11 INFO - PROCESS | 1641 | __end_tp_report 14:41:11 INFO - PROCESS | 1641 | __start_cc_report 14:41:11 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1112 14:41:11 INFO - PROCESS | 1641 | __end_cc_report 14:41:11 INFO - PROCESS | 1641 | __startTimestamp1486766471888__endTimestamp 14:41:11 INFO - PROCESS | 1641 | 14:41:11 INFO - PROCESS | 1641 | ------- Summary: start ------- 14:41:11 INFO - PROCESS | 1641 | Number of tests: 6 14:41:11 INFO - PROCESS | 1641 | 14:41:11 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5777.37 Median:5972.76 stddev:685.14 (11.5%) stddev-sans-first:649.53 14:41:11 INFO - PROCESS | 1641 | Values: 2919.7 3493.5 3515.9 3544.9 3576.2 5736.1 5744.9 5745.6 5761.5 5805.8 4543.4 5755.7 5846.1 5853.9 5864.2 5260.6 5270.6 5275.4 5296.9 5332.8 4209.7 4859.4 5202.1 5355.1 5368.4 4848.9 5243.8 5304.2 5313.3 5317.9 5270.4 5293.3 5296.8 5305.7 5353.5 5176.9 5276.2 5284.3 5286.3 5297.0 5679.2 5696.4 5722.3 5737.8 5832.4 6228.3 6261.9 6294.0 6303.7 6340.3 5239.6 6274.3 6284.6 6306.8 6310.3 5753.6 5798.0 5828.9 5926.8 5970.6 6275.1 6286.4 6315.2 6328.1 6335.5 6259.4 6265.8 6286.6 6294.4 6297.1 6207.2 6249.0 6288.3 6334.6 6341.7 6288.1 6346.3 6346.7 6349.4 6353.0 6312.4 6352.3 6355.4 6371.1 6375.5 4909.0 4966.5 4993.8 5004.1 5044.3 3829.2 4480.7 4511.8 4514.6 4525.8 4848.8 5914.2 5925.4 5933.6 5938.9 6247.3 6289.0 6298.8 6302.6 6311.7 5694.1 5718.6 5814.4 5845.3 5854.9 5506.4 5530.9 5542.3 5548.6 5558.0 6387.3 6399.2 6400.3 6415.3 6416.5 6189.4 6238.6 6293.9 6311.4 6312.6 5069.6 6396.5 6400.8 6402.1 6411.7 6184.8 6224.7 6352.0 6383.8 6386.5 4790.7 6187.6 6210.5 6265.5 6266.7 6202.3 6202.7 6210.1 6224.6 6246.8 5830.8 6155.9 6161.3 6170.1 6187.5 5845.0 5948.6 5965.3 5972.8 6040.6 6164.7 6181.9 6234.2 6248.2 6265.3 6081.7 6094.0 6099.1 6103.6 6116.6 14:41:11 INFO - PROCESS | 1641 | 14:41:11 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:70562.38 Median:19186.65 stddev:158013.17 (823.6%) stddev-sans-first:158368.82 14:41:11 INFO - PROCESS | 1641 | Values: 478.2 485.9 501.4 527.1 541.5 26205.6 33362.7 33390.0 33390.8 41563.8 41446.0 44149.8 44236.8 44335.6 44402.0 9565.0 9689.8 9716.2 9739.6 9751.9 8954.4 9210.0 9566.2 9664.3 9684.9 11484.4 11727.6 11784.8 11965.3 11976.8 9466.6 11740.8 11822.7 11843.1 11865.5 11732.4 11805.4 11819.5 11820.6 11829.8 41452.8 41775.8 41849.0 41872.6 41907.4 3207.3 3367.5 3519.2 3661.1 4008.6 30212.8 30468.8 30854.8 31753.5 32382.0 3269.7 3282.2 3325.5 3346.9 3407.8 502229.0 505577.0 506656.5 507772.0 507924.0 34425.5 34672.1 64274.4 64835.7 65027.0 36544.1 36615.8 36738.9 36845.0 36885.0 15249.1 15461.4 15469.3 15481.8 15522.8 12967.0 13042.1 13071.0 13071.3 13088.4 7580.8 7625.3 7918.7 7951.1 8029.3 2911.8 3340.9 3376.8 3417.1 3441.0 917.6 1002.3 1064.0 1089.7 1124.6 30459.7 30462.8 30469.6 30959.7 31225.8 1115.1 1119.7 1128.4 1165.6 1178.7 15852.4 15907.7 16036.9 16316.7 16481.9 684323.0 688642.0 690538.0 692695.0 692998.0 60770.4 60994.4 61121.7 61344.7 61354.0 1180.8 1266.6 1299.6 1393.3 1417.3 29785.6 30911.4 31688.4 31937.0 32211.8 51355.0 51763.2 51902.5 51909.2 51960.5 555666.0 558140.0 559099.0 559528.0 560168.0 24449.5 24620.6 26247.0 26648.6 26866.7 47723.5 47757.3 47813.0 48142.8 48342.3 38661.8 38909.6 39640.0 39775.0 41027.0 38780.4 39172.4 39235.0 40303.4 40531.6 38345.8 38394.8 38983.8 39130.6 39464.8 27930.6 32544.2 34560.0 34771.3 34854.1 25652.7 25877.2 25990.5 26069.6 26358.6 14:41:11 INFO - PROCESS | 1641 | 14:41:11 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:36314.77 Median:395.61 stddev:106124.19 (26825.4%) stddev-sans-first:106387.59 14:41:11 INFO - PROCESS | 1641 | Values: 380.5 382.3 387.4 395.9 405.6 13751.9 19997.3 20237.3 20721.3 20747.7 15725.9 16970.8 19613.4 20083.6 20088.9 5890.8 6068.9 6110.2 6112.3 6127.8 5755.7 5964.8 6028.6 6054.6 6055.1 6122.4 6132.1 6132.3 6137.0 6148.5 5830.9 5991.1 6074.3 6077.4 6084.9 5889.9 5898.0 5900.8 5927.4 5932.3 13298.5 13504.9 23254.3 23685.5 24686.1 2156.2 2205.4 2266.9 2269.9 2300.0 9778.0 9857.7 10040.7 10188.6 10256.3 1477.4 1719.8 1853.4 1872.0 1890.9 111035.0 125034.0 128577.4 129950.4 133087.3 9143.9 9382.0 9658.5 10806.5 11822.3 15219.5 15220.0 15243.8 15245.3 15284.6 7802.7 8188.1 8228.5 8413.2 8524.1 8675.3 8733.3 8795.0 8843.2 8900.5 4183.9 4608.1 4682.5 4688.2 4751.0 1539.6 1788.9 1796.4 1840.7 1935.8 376.7 387.2 395.3 407.8 821.8 9742.8 11585.8 11649.0 11675.2 12028.0 419.7 428.1 433.8 444.9 446.7 5291.5 5762.1 5950.5 6002.1 6101.9 618758.0 621333.0 630247.0 644522.0 648431.0 138851.0 141482.0 144747.3 145444.0 145583.0 446.4 981.7 1036.5 1050.5 1051.5 16963.9 18871.1 19522.9 19828.0 20315.8 56707.7 57918.7 58118.0 59223.0 60693.0 82357.2 83093.0 85369.6 85599.6 89205.7 7881.0 7997.0 8074.9 8336.4 8340.5 11938.5 12442.9 12864.2 12890.4 13148.8 10931.0 11144.2 11228.1 11449.0 11595.0 10828.9 10971.5 11136.6 11395.6 11449.3 11393.9 11461.1 11692.9 11793.5 11810.9 8215.7 8468.9 8474.4 8514.7 8612.2 9154.4 9289.0 10926.8 10990.5 11182.4 14:41:11 INFO - PROCESS | 1641 | 14:41:11 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5475.84 Median:4982.44 stddev:3001.94 (60.3%) stddev-sans-first:2995.54 14:41:11 INFO - PROCESS | 1641 | Values: 1505.9 1531.6 1712.1 1803.4 1871.6 7242.4 8547.9 8553.7 8559.8 8566.5 7536.8 7819.5 8181.9 8338.4 8355.4 2362.9 2394.3 2400.1 2400.5 2401.1 2378.6 2382.9 2430.3 2438.6 2445.6 2360.1 2364.1 2384.7 2386.0 2388.9 2312.8 2314.3 2337.6 2345.2 2353.3 2375.1 2385.3 2406.0 2409.0 2418.7 8371.0 8456.9 8459.0 8459.3 8468.4 5043.2 5195.2 5198.5 5199.0 5205.6 3439.2 3474.9 3488.8 3566.9 3592.6 1077.4 1078.7 1101.3 1115.2 1119.6 11031.0 11119.5 11126.8 11138.1 11172.1 3883.8 4290.6 4455.5 4718.3 4722.1 8520.4 9568.7 9586.8 9588.8 9595.4 5259.4 5268.4 5269.5 5274.0 5283.3 4112.5 4390.5 4491.1 4861.1 4864.2 3848.2 3853.5 3948.5 3981.8 3986.9 1278.9 1295.3 1296.4 1305.4 1313.3 740.9 840.4 890.3 901.1 902.2 5339.9 5536.6 5554.6 5731.1 5936.0 967.0 970.6 1002.3 1006.7 1031.0 3496.6 3518.6 3545.7 3671.3 3729.5 9836.7 10355.0 10357.5 10357.6 10359.4 9528.0 10245.6 10252.1 10257.4 10277.3 7651.9 7961.2 7975.4 7993.2 8054.2 5217.5 5456.4 5465.2 5476.3 5667.3 9014.0 9199.7 9412.6 9432.2 9477.2 9507.0 9527.0 9547.8 9570.8 9609.6 5412.8 6892.9 7056.0 7125.4 7283.5 7934.2 8130.0 8140.8 8145.3 8151.8 7073.0 7188.3 7205.9 7235.6 7332.6 7021.0 7036.5 7086.8 7168.3 7221.0 6687.7 6689.1 6759.2 6762.0 6774.6 4659.9 4673.4 4709.1 4723.5 4753.2 4621.8 4658.9 4684.4 4861.1 4921.7 14:41:11 INFO - PROCESS | 1641 | 14:41:11 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4486.86 Median:4981.18 stddev:1354.89 (27.2%) stddev-sans-first:1321.27 14:41:11 INFO - PROCESS | 1641 | Values: 274.0 290.7 313.3 317.9 321.4 4526.9 5440.8 5450.0 5467.6 5579.9 5142.9 5262.5 5355.8 5369.5 5517.4 4123.3 4144.4 4149.1 4165.5 4186.2 4155.9 4165.3 4168.6 4170.2 4229.5 3428.0 3845.7 4025.0 4083.4 4174.4 4115.6 4142.8 4162.7 4169.6 4175.2 2860.5 3144.4 3608.8 3622.3 3627.3 4643.3 5148.4 5302.6 5337.6 5349.2 3839.3 4152.1 4403.3 4686.9 4723.6 5580.1 5647.2 5672.6 5685.2 5715.3 3369.4 3892.3 4032.3 4041.4 4044.8 5219.6 5233.7 5563.6 5890.7 5952.1 3429.5 3432.7 4040.9 4066.9 4091.9 4132.5 4136.2 4155.7 4201.3 4208.9 4480.6 4749.2 4784.4 4811.4 4824.8 4801.0 4892.6 5328.2 5582.1 5762.5 1171.9 1312.7 1382.0 1389.7 1395.7 900.8 920.7 932.4 935.8 948.3 4338.4 4485.3 4515.2 4972.7 5103.7 4509.8 4876.5 5344.3 5351.1 5658.3 4366.6 4944.9 5020.8 5090.6 5375.4 2532.7 2743.8 2757.4 2795.9 2921.6 5450.6 5534.7 5809.8 5817.6 5830.4 5428.3 5741.7 5749.9 5751.6 5756.5 4786.4 5187.4 5512.8 5638.6 5845.7 4818.4 5269.9 5556.5 5686.8 5730.4 5113.8 5261.3 5459.9 5492.3 5555.2 4860.7 5799.5 5803.8 5805.3 5850.4 3344.6 3438.4 3514.6 3555.4 3663.4 4895.4 5040.9 5119.1 5594.9 5600.5 4489.8 4941.0 5280.0 5336.7 5401.8 4736.6 4757.0 5222.6 5309.1 5459.2 4662.8 4989.7 5407.0 5453.7 5537.4 5291.9 5327.7 5681.6 5750.8 5786.9 5195.2 5419.3 5564.7 5656.5 5793.5 14:41:11 INFO - PROCESS | 1641 | 14:41:11 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:21041.02 Median:538.71 stddev:31460.67 (5840.0%) stddev-sans-first:31511.82 14:41:11 INFO - PROCESS | 1641 | Values: 691.4 738.7 765.6 780.0 828.5 14042.2 14839.9 14858.4 14942.6 15010.6 13347.1 13491.8 13495.6 13500.5 13507.1 712.6 717.2 735.0 849.6 881.3 859.7 869.3 873.6 880.3 882.2 922.7 923.1 923.2 923.9 925.8 912.0 916.7 918.2 919.2 919.9 680.9 681.1 682.0 682.1 682.7 13477.6 13656.0 13660.1 13671.7 14226.5 13748.3 14054.4 14054.5 14245.9 14306.7 11313.4 11424.9 11466.3 11643.0 11680.4 3796.6 3817.4 3858.2 3896.0 3943.0 89062.0 92773.0 92809.0 96116.0 97547.0 10297.4 10546.0 10787.9 10864.1 10869.5 20898.7 21245.8 21410.0 21485.4 21494.1 7377.2 7429.0 7766.3 7801.0 7988.8 4305.2 4411.6 4468.4 4485.5 4616.7 2836.3 3147.2 3256.4 3256.8 3361.1 628.0 628.7 657.9 672.0 699.9 576.6 638.6 650.3 651.3 654.9 8720.7 8809.3 9065.0 9133.4 9176.4 512.5 564.9 612.6 659.3 668.4 4189.5 4445.9 4489.3 4523.1 4575.4 81105.0 111052.9 111065.9 111971.4 118397.0 98478.0 102060.5 103046.5 104096.0 109422.5 66682.7 84446.0 85561.1 87862.6 89146.0 8187.8 8389.8 8665.3 8667.7 8782.2 58576.0 59369.4 60132.7 60156.0 61671.4 76176.0 84971.3 85768.0 87239.0 87804.2 10068.7 11292.8 11354.3 11646.9 11788.1 10958.8 12470.9 12748.2 12844.6 13158.6 11242.7 11546.2 11862.6 12075.0 12342.8 11207.6 11676.8 11854.3 12363.5 12485.9 11168.9 11313.5 12152.3 12171.0 12589.9 9752.4 9930.8 9947.2 10037.9 10050.5 9806.7 9874.0 9882.6 9888.2 9905.6 14:41:11 INFO - PROCESS | 1641 | -------- Summary: end -------- 14:41:11 INFO - PROCESS | 1641 | 14:41:12 INFO - TEST-INFO | 1641: exit 0 14:41:12 INFO - TEST-OK | dromaeo_css | took 1117033ms 14:41:12 INFO - TEST-START | kraken 14:41:12 INFO - operating with platform_type : mac_ 14:41:12 INFO - Initialising browser for kraken test... 14:41:12 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpsaDIF7/profile http://localhost:49241/getInfo.html) 14:41:14 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 14:41:14 INFO - PROCESS | 1652 | colorDepth:24 14:41:14 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 14:41:14 INFO - PROCESS | 1652 | __metrics 14:41:15 INFO - PROCESS | 1652 | 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" 14:41:15 INFO - PROCESS | 1652 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:41:15 INFO - TEST-INFO | 1652: exit 0 14:41:15 INFO - Browser initialized. 14:41:15 INFO - Running cycle 1/1 for kraken test... 14:41:15 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpsaDIF7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:41:28 INFO - PROCESS | 1654 | RSS: Main: 172023808 14:41:28 INFO - PROCESS | 1654 | 14:41:30 INFO - PROCESS | 1654 | 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) 14:41:31 INFO - PROCESS | 1654 | RSS: Main: 221999104 14:41:31 INFO - PROCESS | 1654 | 14:41:34 INFO - PROCESS | 1654 | 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) 14:41:34 INFO - PROCESS | 1654 | RSS: Main: 234188800 14:41:34 INFO - PROCESS | 1654 | 14:41:37 INFO - PROCESS | 1654 | 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) 14:41:38 INFO - PROCESS | 1654 | RSS: Main: 331370496 14:41:38 INFO - PROCESS | 1654 | 14:41:40 INFO - PROCESS | 1654 | 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) 14:41:41 INFO - PROCESS | 1654 | RSS: Main: 234782720 14:41:41 INFO - PROCESS | 1654 | 14:41:43 INFO - PROCESS | 1654 | 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) 14:41:43 INFO - PROCESS | 1654 | RSS: Main: 235520000 14:41:43 INFO - PROCESS | 1654 | 14:41:46 INFO - PROCESS | 1654 | 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) 14:41:47 INFO - PROCESS | 1654 | RSS: Main: 275714048 14:41:47 INFO - PROCESS | 1654 | 14:41:50 INFO - PROCESS | 1654 | 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) 14:41:50 INFO - PROCESS | 1654 | RSS: Main: 276586496 14:41:50 INFO - PROCESS | 1654 | 14:41:53 INFO - PROCESS | 1654 | 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) 14:41:53 INFO - PROCESS | 1654 | RSS: Main: 274907136 14:41:53 INFO - PROCESS | 1654 | 14:41:55 INFO - PROCESS | 1654 | 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) 14:41:56 INFO - PROCESS | 1654 | RSS: Main: 249081856 14:41:56 INFO - PROCESS | 1654 | 14:41:57 INFO - PROCESS | 1654 | 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) 14:41:58 INFO - PROCESS | 1654 | RSS: Main: 252207104 14:41:58 INFO - PROCESS | 1654 | 14:42:00 INFO - PROCESS | 1654 | 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) 14:42:01 INFO - PROCESS | 1654 | RSS: Main: 254406656 14:42:01 INFO - PROCESS | 1654 | 14:42:04 INFO - PROCESS | 1654 | 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) 14:42:05 INFO - PROCESS | 1654 | RSS: Main: 269828096 14:42:05 INFO - PROCESS | 1654 | 14:42:07 INFO - PROCESS | 1654 | 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) 14:42:08 INFO - PROCESS | 1654 | RSS: Main: 263913472 14:42:08 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | 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) 14:42:10 INFO - PROCESS | 1654 | RSS: Main: 308031488 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | __start_tp_report 14:42:10 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 14:42:10 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 14:42:10 INFO - PROCESS | 1654 | |i|pagename|runs| 14:42:10 INFO - PROCESS | 1654 | |0;ai-astar;114;116;114;115;115;114;113;115;113;115 14:42:10 INFO - PROCESS | 1654 | |1;audio-beat-detection;145;108;107;140;108;109;142;103;168;137 14:42:10 INFO - PROCESS | 1654 | |2;audio-dft;182;182;180;186;181;182;185;182;182;185 14:42:10 INFO - PROCESS | 1654 | |3;audio-fft;79;57;58;87;59;59;63;65;107;82 14:42:10 INFO - PROCESS | 1654 | |4;audio-oscillator;89;69;92;70;69;67;87;67;68;90 14:42:10 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;87;84;88;85;88;85;89;85;88;84 14:42:10 INFO - PROCESS | 1654 | |6;imaging-darkroom;94;112;148;120;93;94;94;94;94;95 14:42:10 INFO - PROCESS | 1654 | |7;imaging-desaturate;83;81;79;78;84;83;85;83;81;81 14:42:10 INFO - PROCESS | 1654 | |8;json-parse-financial;52;51;51;53;56;78;65;57;56;55 14:42:10 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;68;68;73;72;70;67;67;68;67;67 14:42:10 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;82;83;81;92;100;97;79;81;81;91 14:42:10 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;141;139;144;132;137;139;141;141;177;129 14:42:10 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;161;159;160;163;160;159;218;218;159;165 14:42:10 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;67;67;66;66;66;66;64;64;64;65 14:42:10 INFO - PROCESS | 1654 | __end_tp_report 14:42:10 INFO - PROCESS | 1654 | __start_cc_report 14:42:10 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1983 14:42:10 INFO - PROCESS | 1654 | __end_cc_report 14:42:10 INFO - PROCESS | 1654 | __startTimestamp1486766530531__endTimestamp 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | ------- Summary: start ------- 14:42:10 INFO - PROCESS | 1654 | Number of tests: 14 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 14:42:10 INFO - PROCESS | 1654 | Values: 114.0 116.0 114.0 115.0 115.0 114.0 113.0 115.0 113.0 115.0 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:138.50 stddev:22.41 (16.2%) stddev-sans-first:22.77 14:42:10 INFO - PROCESS | 1654 | Values: 145.0 108.0 107.0 140.0 108.0 109.0 142.0 103.0 168.0 137.0 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:182.70 Median:182.00 stddev:1.95 (1.1%) stddev-sans-first:2.05 14:42:10 INFO - PROCESS | 1654 | Values: 182.0 182.0 180.0 186.0 181.0 182.0 185.0 182.0 182.0 185.0 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:71.60 Median:64.00 stddev:16.62 (26.0%) stddev-sans-first:17.41 14:42:10 INFO - PROCESS | 1654 | Values: 79.0 57.0 58.0 87.0 59.0 59.0 63.0 65.0 107.0 82.0 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:78.50 stddev:11.03 (14.1%) stddev-sans-first:10.78 14:42:10 INFO - PROCESS | 1654 | Values: 89.0 69.0 92.0 70.0 69.0 67.0 87.0 67.0 68.0 90.0 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.50 stddev:1.89 (2.2%) stddev-sans-first:1.99 14:42:10 INFO - PROCESS | 1654 | Values: 87.0 84.0 88.0 85.0 88.0 85.0 89.0 85.0 88.0 84.0 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:103.80 Median:94.00 stddev:18.13 (19.3%) stddev-sans-first:18.88 14:42:10 INFO - PROCESS | 1654 | Values: 94.0 112.0 148.0 120.0 93.0 94.0 94.0 94.0 94.0 95.0 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:81.80 Median:83.00 stddev:2.20 (2.7%) stddev-sans-first:2.29 14:42:10 INFO - PROCESS | 1654 | Values: 83.0 81.0 79.0 78.0 84.0 83.0 85.0 83.0 81.0 81.0 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:56.00 stddev:8.32 (14.8%) stddev-sans-first:8.59 14:42:10 INFO - PROCESS | 1654 | Values: 52.0 51.0 51.0 53.0 56.0 78.0 65.0 57.0 56.0 55.0 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.00 stddev:2.21 (3.3%) stddev-sans-first:2.33 14:42:10 INFO - PROCESS | 1654 | Values: 68.0 68.0 73.0 72.0 70.0 67.0 67.0 68.0 67.0 67.0 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:82.50 stddev:7.62 (9.2%) stddev-sans-first:7.89 14:42:10 INFO - PROCESS | 1654 | Values: 82.0 83.0 81.0 92.0 100.0 97.0 79.0 81.0 81.0 91.0 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:141.00 stddev:13.10 (9.3%) stddev-sans-first:13.89 14:42:10 INFO - PROCESS | 1654 | Values: 141.0 139.0 144.0 132.0 137.0 139.0 141.0 141.0 177.0 129.0 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:162.00 stddev:24.22 (14.9%) stddev-sans-first:25.34 14:42:10 INFO - PROCESS | 1654 | Values: 161.0 159.0 160.0 163.0 160.0 159.0 218.0 218.0 159.0 165.0 14:42:10 INFO - PROCESS | 1654 | 14:42:10 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.18 (1.8%) stddev-sans-first:1.12 14:42:10 INFO - PROCESS | 1654 | Values: 67.0 67.0 66.0 66.0 66.0 66.0 64.0 64.0 64.0 65.0 14:42:10 INFO - PROCESS | 1654 | -------- Summary: end -------- 14:42:10 INFO - PROCESS | 1654 | 14:42:11 INFO - TEST-INFO | 1654: exit 0 14:42:11 INFO - TEST-OK | kraken | took 59047ms 14:42:11 INFO - SUITE-END | took 1176s 14:42:11 INFO - Completed test suite (00:19:36) 14:42:11 INFO - javascript benchmark 14:42:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2919.69343218962, 3493.4934434507004, 3515.859365625375, 3544.85820567177, 3576.2311103112825, 5736.053551164053, 5744.856378590527, 5745.597808153426, 5761.4814666679995, 5805.825825225239, 4543.432070991126, 5755.740991655375, 5846.123081537761, 5853.853653658661, 5864.208331875196, 5260.631755777097, 5270.578353731692, 5275.446078161785, 5296.947030529704, 5332.760025798849, 4209.663226941852, 4859.368282123319, 5202.089634313998, 5355.0896347621, 5368.382635996852, 4848.927266091011, 5243.816466423676, 5304.230886521452, 5313.309269794921, 5317.9468205318035, 5270.446603106657, 5293.311869456946, 5296.761645725913, 5305.708186049766, 5353.518183363516, 5176.896462070775, 5276.182191760283, 5284.260203571503, 5286.3392075990505, 5297.020051290524, 5679.176519404663, 5696.401877802854, 5722.341930677983, 5737.799177028825, 5832.358440571534, 6228.34602366754, 6261.906071408933, 6293.992961126243, 6303.684815759194, 6340.270868850049, 5239.607029472767, 6274.349597951392, 6284.5600807943465, 6306.779262725782, 6310.337414571496, 5753.568482363756, 5798.0, 5828.941710582924, 5926.7925622603, 5970.641761494324, 6275.121482992385, 6286.402791734778, 6315.210598675166, 6328.050792381087, 6335.524835637346, 6259.374062593704, 6265.8120256392385, 6286.591371560926, 6294.433500984934, 6297.118403423525, 6207.224096987877, 6249.0, 6288.276848162428, 6334.588251763621, 6341.714622841983, 6288.119663247149, 6346.333634968354, 6346.714397852108, 6349.365063493614, 6352.968235158794, 6312.380362149656, 6352.333005034498, 6355.396237357444, 6371.139896114058, 6375.521835862329, 4909.042736666316, 4966.478519755374, 4993.7503124843615, 5004.07424626438, 5044.319016932741, 3829.195868867513, 4480.686351955332, 4511.819527218874, 4514.6388288936805, 4525.841595544141, 4848.757562121879, 5914.231149950565, 5925.4074592541265, 5933.554983376264, 5938.940610593925, 6247.250329960434, 6289.0, 6298.842528936813, 6302.590331628429, 6311.715972781236, 5694.117411801178, 5718.628289161191, 5814.447627475383, 5845.298564172242, 5854.8536286592325, 5506.449355064461, 5530.944690553123, 5542.307211598551, 5548.611597188158, 5557.972210138923, 6387.265464471645, 6399.200099987502, 6400.327965563642, 6415.294317624965, 6416.486681065504, 6189.442950134509, 6238.625682459067, 6293.905591416224, 6311.431971122621, 6312.5581209314905, 5069.6197785167, 6396.456301214263, 6400.775972840928, 6402.071699603624, 6411.6794160290865, 6184.783532576338, 6224.719887604978, 6351.96824015877, 6383.808485745435, 6386.489080873612, 4790.664653474223, 6187.597806142587, 6210.534209934363, 6265.498760099273, 6266.749330026748, 6202.2867370253, 6202.658853763086, 6210.130581718473, 6224.564280500503, 6246.750129994749, 5830.82507524775, 6155.907661384993, 6161.260648722182, 6170.136180934583, 6187.535934804998, 5844.970775146097, 5948.613340132878, 5965.254343207099, 5972.761089556369, 6040.577159598962, 6164.660943648142, 6181.938180618136, 6234.220722409699, 6248.156498872776, 6265.279492858197, 6081.665508397081, 6093.969530152321, 6099.146119543356, 6103.572749907464, 6116.5718399711595], "value": 5734.65479526757, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.2372116474223, 485.8761015940934, 501.43087595579004, 527.0855066459694, 541.4991133201788, 26205.606915896253, 33362.66549338029, 33390.0, 33390.83304583477, 41563.79218103913, 41446.0, 44149.77925110378, 44236.77881610596, 44335.55664443355, 44402.0, 9564.995675454064, 9689.806203875918, 9716.174125199366, 9739.561719722595, 9751.90248097517, 8954.37319387643, 9209.95395023024, 9566.186874115674, 9664.323497355188, 9684.903150968506, 11484.425778711073, 11727.648170554854, 11784.7643047139, 11965.341906195155, 11976.820347694791, 9466.574004169828, 11740.765184696302, 11822.704432389173, 11843.111766617452, 11865.52537898483, 11732.413379331, 11805.350705711267, 11819.468123934357, 11820.645380638594, 11829.763404731857, 41452.79273603643, 41775.7911210445, 41849.0, 41872.581274187476, 41907.37138942918, 3207.294395233045, 3367.461206206995, 3519.1729943463265, 3661.121330880596, 4008.579099194572, 30212.8489357554, 30468.84765576158, 30854.84572577145, 31753.523697144563, 32382.0, 3269.673032696735, 3282.179455136216, 3325.4679251319913, 3346.8995930122137, 3407.778494397881, 502229.0, 505577.0, 506656.46671766776, 507772.0, 507924.0, 34425.483617745755, 34672.133196670286, 64274.39314017187, 64835.67582162059, 65027.0, 36544.08639784026, 36615.816920915226, 36738.89783306505, 36845.0, 36885.0, 15249.085054896741, 15461.38154473831, 15469.303881325368, 15481.83886208539, 15522.767158492632, 12967.027472939568, 13042.087053906136, 13071.0, 13071.281079540717, 13088.411021504055, 7580.772576822704, 7625.275598818214, 7918.722844700523, 7951.125376208613, 8029.317508011768, 2911.8398488082935, 3340.866365345359, 3376.848041838123, 3417.1457135716073, 3440.9827950860085, 917.6421195733669, 1002.2633364477103, 1063.9734006649742, 1089.743910181107, 1124.6457365929707, 30459.695403046127, 30462.84768576143, 30469.592301241828, 30959.69040309568, 31225.8438707805, 1115.1134847796022, 1119.7032786311634, 1128.373752567333, 1165.551262763842, 1178.6640807369859, 15852.44516441919, 15907.681846363008, 16036.919815401081, 16316.694664427056, 16481.917590411973, 684323.0, 688642.0, 690538.0, 692695.0, 692998.0, 60770.392296077356, 60994.39005609976, 61121.69439152776, 61344.69327653333, 61354.0, 1180.8346831443775, 1266.5756971414496, 1299.551654679153, 1393.2754967416886, 1417.2701058954647, 29785.5532167022, 30911.381772363977, 31688.366232674758, 31937.041888743373, 32211.838940806083, 51355.0, 51763.22355164751, 51902.48097518976, 51909.221361680364, 51960.480395197075, 555666.0, 558140.0, 559099.0, 559528.0, 560168.0, 24449.511009779348, 24620.630690540016, 26247.0, 26648.60027099556, 26866.731332686424, 47723.5227647733, 47757.283640744725, 47813.0, 48142.75928620334, 48342.27486587774, 38661.80669096749, 38909.6109038906, 39640.0, 39775.0, 41027.0, 38780.41829372505, 39172.41241381439, 39235.0, 40303.3954490677, 40531.59468405278, 38345.80827095846, 38394.80802595969, 38983.805080974416, 39130.6086939127, 39464.81605551838, 27930.581041284804, 32544.186395340304, 34560.0, 34771.30457390787, 34854.12864678403, 25652.743472565035, 25877.223683289532, 25990.480190396465, 26069.565821535398, 26358.604620930317], "value": 19204.98817127507, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.46354639957667, 382.298482285007, 387.3872133238018, 395.92477429288425, 405.6308759029284, 13751.862481375183, 19997.300094496695, 20237.291694790685, 20721.274755383565, 20747.688784668222, 15725.92137039316, 16970.83029169708, 19613.41159765206, 20083.598328033466, 20088.899555502237, 5890.823275301748, 6068.908966365508, 6110.236220472441, 6112.327643959161, 6127.846803829918, 5755.740991655364, 5964.79123230687, 6028.63828170309, 6054.606450580698, 6055.061465472837, 6122.448979591836, 6132.141500189977, 6132.325444201157, 6137.048757442603, 6148.538859585549, 5830.854228644296, 5991.071383935475, 6074.271087469532, 6077.4226448487325, 6084.878302433971, 5889.911651325234, 5898.026825573776, 5900.822975310747, 5927.37762534932, 5932.3177834548715, 13298.534551290755, 13504.864951350459, 23254.30237092873, 23685.526289474285, 24686.13598524061, 2156.212982261479, 2205.3935167828977, 2266.8866556672265, 2269.8524595901213, 2299.965500517477, 9778.022197780165, 9857.654982075665, 10040.748981275454, 10188.64358646621, 10256.33333833306, 1477.3868844429655, 1719.8305152496298, 1853.406909788868, 1872.0, 1890.933817316401, 111035.0, 125034.0, 128577.35711321383, 129950.3502482491, 133087.33456332755, 9143.94844592867, 9382.0, 9658.468784216795, 10806.459677016117, 11822.280875398706, 15219.543413697607, 15220.0, 15243.847561524464, 15245.313960871566, 15284.617884552752, 7802.687892484237, 8188.058373287148, 8228.465149765367, 8413.200745929127, 8524.104968978168, 8675.305975521944, 8733.34499912509, 8794.95602521996, 8843.248323892412, 8900.486917223958, 4183.91632167355, 4608.078384323148, 4682.531746825291, 4688.156131896291, 4750.976245118753, 1539.6074001129864, 1788.8694784127777, 1796.3712700554702, 1840.723512148378, 1935.8064193580528, 376.6911132871019, 387.2429400521973, 395.29637245702696, 407.83278855669624, 821.8068753842842, 9742.756431089138, 11585.826212606818, 11649.0, 11675.241109327866, 12028.0, 419.6642685851307, 428.08390045303076, 433.79177994562787, 444.8776586438755, 446.68062335429676, 5291.470852914677, 5762.1068734346245, 5950.494207992283, 6002.069679199643, 6101.938980610226, 618758.0, 621333.0, 630247.0, 644522.0, 648431.0, 138851.0, 141482.0, 144747.276263618, 145444.0, 145583.0, 446.4174252600388, 981.7251169672503, 1036.5180191211123, 1050.4642632257603, 1051.453244312953, 16963.915180424017, 18871.05644717731, 19522.90238548798, 19828.0, 20315.796842031392, 56707.716461417425, 57918.71040644938, 58118.0, 59223.0, 60693.0, 82357.17642823495, 83093.0, 85369.57315213385, 85599.5720021396, 89205.66191507003, 7880.960595196987, 7997.0078543822465, 8074.919250807417, 8336.416450848625, 8340.541270230196, 11938.462769175234, 12442.937785311016, 12864.22814631125, 12890.355482225663, 13148.80276795868, 10931.01620854127, 11144.2199046066, 11228.101751859995, 11449.026832719312, 11595.0, 10828.891711082788, 10971.50628221716, 11136.55453781872, 11395.601153959571, 11449.313041217554, 11393.886061139614, 11461.083113351078, 11692.88307116952, 11793.52825886955, 11810.881891181321, 8215.671373145007, 8468.872966905625, 8474.406791524534, 8514.74455766328, 8612.224899758801, 9154.359194856295, 9289.0, 10926.836097458703, 10990.505427255952, 11182.384968826793], "value": 8879.66314400339, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1505.9247037648122, 1531.6062383231258, 1712.1011468978784, 1803.440933310673, 1871.6350311689218, 7242.420606351492, 8547.871781923268, 8553.700620478285, 8559.78600534986, 8566.528840913763, 7536.849263014737, 7819.530828150315, 8181.877271840927, 8338.416310858242, 8355.37334699897, 2362.881855907202, 2394.281715485356, 2400.099962514057, 2400.5078958813488, 2401.0875867170453, 2378.63131214662, 2382.880855957204, 2430.2830664953794, 2438.6463962725393, 2445.6331550267423, 2360.091364824538, 2364.137089962169, 2384.6899903012672, 2386.0336563691644, 2388.916387926423, 2312.7571604981404, 2314.271004633535, 2337.6026075567192, 2345.2377977157494, 2353.3293011491814, 2375.121205154087, 2385.296337580418, 2406.0255596483453, 2409.024345140221, 2418.709754829414, 8370.958145209295, 8456.915430845736, 8458.957705211496, 8459.323254139654, 8468.407211495198, 5043.193089105762, 5195.246689230078, 5198.506141916512, 5199.0381779370555, 5205.609579281569, 3439.226174110805, 3474.878379256739, 3488.8255587220538, 3566.857325706969, 3592.568891733009, 1077.4000609095488, 1078.654830454255, 1101.2841652925583, 1115.2026301194603, 1119.6361182615601, 11031.0, 11119.499622517005, 11126.777464450666, 11138.053265472445, 11172.050375718074, 3883.76697398157, 4290.6269993601745, 4455.509893911667, 4718.3158442025715, 4722.079194557097, 8520.360972927056, 9568.712938611852, 9586.760330991781, 9588.808223835484, 9595.376300540442, 5259.447757985433, 5268.446813084571, 5269.4730526947, 5273.973630131824, 5283.339582552181, 4112.506499220053, 4390.495093064274, 4491.146682130385, 4861.076395484846, 4864.197407427735, 3848.249046683752, 3853.460515527828, 3948.506436695413, 3981.820818063194, 3986.9202615948097, 1278.9296588687712, 1295.3393769177599, 1296.4425297122327, 1305.3995162225483, 1313.2645718397728, 740.9110906691124, 840.4117118017413, 890.2610833008716, 901.1124042817819, 902.1700035966926, 5339.893202136013, 5536.557075433956, 5554.583406244547, 5731.111677689964, 5935.961206788881, 966.9564869580886, 970.631160159135, 1002.3033991376069, 1006.7483129217695, 1030.9742256443499, 3496.5804103507235, 3518.5601799775027, 3545.7163426925786, 3671.2657468506404, 3729.4734215123535, 9836.704898853046, 10355.0, 10357.482125893675, 10357.63748268807, 10359.378437293786, 9528.0, 10245.590176392861, 10252.128569071712, 10257.435841028815, 10277.280590358752, 7651.885221721679, 7961.243681850215, 7975.441719079725, 7993.200679931961, 8054.23484768946, 5217.530422262014, 5456.399796022513, 5465.207544905887, 5476.342838859362, 5667.2632557768875, 9014.008459069628, 9199.724008279762, 9412.576434060347, 9432.198263147435, 9477.241820654193, 9507.001764814595, 9527.0, 9547.809043819223, 9570.808583828146, 9609.615615375307, 5412.7564259607625, 6892.896606551006, 7056.0, 7125.394341480825, 7283.490155689263, 7934.246246606564, 8129.959350203211, 8140.75577732669, 8145.307648849915, 8151.79620509492, 7072.9646351767915, 7188.317109874553, 7205.855882882208, 7235.565866048054, 7332.596707180943, 7020.964895175695, 7036.472264580075, 7086.822829429306, 7168.319009694071, 7220.963895180701, 6687.732490700318, 6689.09697190873, 6759.222689390586, 6761.966190169018, 6774.559653622696, 4659.860204193879, 4673.369095172108, 4709.058188362273, 4723.456802467623, 4753.168195565693, 4621.768911554342, 4658.930116048195, 4684.367610372556, 4861.052094841472, 4921.680090794087], "value": 4459.260605120633, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.9657542807149, 290.7354307580102, 313.2919601700158, 317.90939582219073, 321.36851087612837, 4526.932096018558, 5440.836774896755, 5449.972750136254, 5467.644603100795, 5579.9163012554845, 5142.871428214287, 5262.526372626463, 5355.758990845412, 5369.476346117328, 5517.36550296716, 4123.299039163335, 4144.399062135996, 4149.070682132823, 4165.520965089023, 4186.204621121992, 4155.92203898051, 4165.291900376943, 4168.583141685837, 4170.165966806636, 4229.477388140267, 3428.0, 3845.6731177849915, 4025.0339918419663, 4083.3874918762276, 4174.394712766662, 4115.629593336614, 4142.813573389205, 4162.729422587552, 4169.603887630686, 4175.202614248446, 2860.4994126027864, 3144.3868445653106, 3608.765430247052, 3622.2755448910325, 3627.292677927805, 4643.349931009661, 5148.407933087706, 5302.602304827154, 5337.626366154371, 5349.224362467459, 3839.2513459875336, 4152.107296931144, 4403.339499075132, 4686.851721328297, 4723.5984941279685, 5580.074874168446, 5647.237622920894, 5672.574556908207, 5685.232493613392, 5715.342735585419, 3369.444041733111, 3892.3188442022815, 4032.254033003874, 4041.4336896070913, 4044.8382064717375, 5219.582433405319, 5233.712145831978, 5563.582731295169, 5890.698371465673, 5952.107183922403, 3429.5027221053306, 3432.6910578048096, 4040.939385909214, 4066.898327541835, 4091.8772436826944, 4132.5454200037975, 4136.152088821785, 4155.667546596265, 4201.264778663722, 4208.894777630584, 4480.596746292849, 4749.24012158053, 4784.449788274393, 4811.374521312207, 4824.769683730627, 4801.0, 4892.624089378318, 5328.227407025959, 5582.106862901916, 5762.4525670061275, 1171.8652354979286, 1312.7308901675133, 1381.9773367707824, 1389.6595334142999, 1395.7278330725615, 900.7658008917729, 920.7467946314817, 932.3753085432776, 935.7707361696428, 948.3029972969862, 4338.370936214231, 4485.282354823213, 4515.164694531522, 4972.65191436596, 5103.668261562986, 4509.7970591323465, 4876.536729010809, 5344.305240318734, 5351.143816989263, 5658.321001479767, 4366.607005369532, 4944.901101978012, 5020.849374518771, 5090.567301779391, 5375.408705042442, 2532.696076470835, 2743.7804975602303, 2757.4485102979083, 2795.8602069896424, 2921.561765735114, 5450.591205659592, 5534.695591742412, 5809.767609295581, 5817.592768506249, 5830.416958304136, 5428.267183930119, 5741.712914354349, 5749.936261791582, 5751.568632352591, 5756.539476841843, 4786.444405568204, 5187.377514698261, 5512.80705175317, 5638.588653864435, 5845.707714614167, 4818.397700287464, 5269.947300526946, 5556.471970208225, 5686.829395117988, 5730.426957304237, 5113.795448182031, 5261.289725886956, 5459.890802183854, 5492.336216934704, 5555.194496798023, 4860.719014665157, 5799.4780469757925, 5803.82588522345, 5805.274340707411, 5850.414958504286, 3344.565206523234, 3438.3639026780124, 3514.6309637488716, 3555.4311310190246, 3663.377225871555, 4895.37032412714, 5040.949590504195, 5119.052975199451, 5594.888102238014, 5600.4959553640365, 4489.842855500042, 4941.023590563803, 5280.049591073644, 5336.706481143575, 5401.837944861661, 4736.644751643572, 4756.9762151189025, 5222.55608273301, 5309.123994540858, 5459.235707001102, 4662.836800711959, 4989.700617962933, 5407.0, 5453.673259311896, 5537.446255374431, 5291.947080529146, 5327.733613319241, 5681.573881958952, 5750.827475175752, 5786.9131963019745, 5195.220716892345, 5419.3225846769155, 5564.721763911869, 5656.519195868233, 5793.478586927196], "value": 4057.334087139, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.4053913634275, 738.6749830074764, 765.6095391350414, 779.9727009554663, 828.5484410996008, 14042.157470551761, 14839.925800370984, 14858.405663773436, 14942.626434339134, 15010.624734381647, 13347.132436391628, 13491.797623035662, 13495.59513214605, 13500.527481538149, 13507.12203706761, 712.5866997141671, 717.2468907646963, 735.0187499687896, 849.6261644876234, 881.2685471059037, 859.6948083430386, 869.2784988459564, 873.6243415331405, 880.2649787427506, 882.1531329923249, 922.7462447826834, 923.0538697834706, 923.2291036984093, 923.8983711791698, 925.7546750111226, 911.9831388002395, 916.7478943290582, 918.1782304837167, 919.1865199298635, 919.8620206969008, 680.8706345794333, 681.1247546902256, 682.0383259603934, 682.0928165539821, 682.7200847652439, 13477.595672129852, 13656.04407691462, 13660.112092714042, 13671.658208544766, 14226.502072427518, 13748.307443252483, 14054.437822487089, 14054.478888933056, 14245.857541424557, 14306.713865722731, 11313.377764222965, 11424.942875285653, 11466.312021278667, 11643.01034412076, 11680.357580333079, 3796.5960526903027, 3817.408301713239, 3858.189780146173, 3896.0259935016247, 3943.0, 89062.0, 92773.0, 92809.0, 96116.0, 97547.02452975522, 10297.3821570706, 10546.0, 10787.892121078845, 10864.130869530418, 10869.510872010778, 20898.686519702216, 21245.78754212469, 21410.03654835536, 21485.355439336843, 21494.14023439045, 7377.225391333833, 7428.9628551856895, 7766.339861111869, 7801.0, 7988.760337189894, 4305.203537345601, 4411.558844115562, 4468.419105516262, 4485.506594274627, 4616.6537509686905, 2836.290927268183, 3147.213196700825, 3256.3650088232566, 3256.788308759923, 3361.09250502363, 627.9780207692709, 628.707650942314, 657.8552718401944, 671.9529632925746, 699.9370056694922, 576.5618130221062, 638.5976834594176, 650.2554575011585, 651.280335229574, 654.8722999015241, 8720.738377848675, 8809.33929955256, 9064.954675226714, 9133.40632858862, 9176.403533770284, 512.4951922356476, 564.9180868774005, 612.5865041097242, 659.3011407907633, 668.4351722794231, 4189.539150693421, 4445.866624001285, 4489.281714925596, 4523.095380923828, 4575.405197324327, 81105.0, 111052.88947110425, 111065.88934110718, 111971.44014279876, 118397.0, 98478.0, 102060.48969755252, 103046.48476757568, 104096.0, 109422.45288773664, 66682.66658666676, 84445.99999999878, 85561.14438855657, 87862.56068719615, 89146.0, 8187.754367368989, 8389.790255243424, 8665.306775457822, 8667.696630617898, 8782.209601135928, 58576.0, 59369.40630593639, 60132.69933650479, 60156.0, 61671.383286166565, 76176.0, 84971.30057398941, 85768.0, 87239.0, 87804.24391512261, 10068.748281293027, 11292.830607540729, 11354.318740875575, 11646.941765291458, 11788.056955443373, 10958.835617465586, 12470.875291246972, 12748.171368860994, 12844.614661560168, 13158.60524184276, 11242.66272011841, 11546.249493782878, 11862.584809531625, 12075.0, 12342.81485777732, 11207.551697931991, 11676.766464670489, 11854.348010859485, 12363.454568178977, 12485.93757031209, 11168.944155279172, 11313.547458101913, 12152.331621760888, 12171.0, 12589.87410125887, 9752.414855108716, 9930.751731206778, 9947.154491868272, 10037.949810250902, 10050.547725352231, 9806.65676701312, 9874.0, 9882.555285012335, 9888.208943284664, 9905.554250058909], "value": 7278.805813128207, "unit": "score"}], "name": "dromaeo_css", "value": 7106.47729021958, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 114.0, 115.0, 115.0, 114.0, 113.0, 115.0, 113.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 108.0, 107.0, 140.0, 108.0, 109.0, 142.0, 103.0, 168.0, 137.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 180.0, 186.0, 181.0, 182.0, 185.0, 182.0, 182.0, 185.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 58.0, 87.0, 59.0, 59.0, 63.0, 65.0, 107.0, 82.0], "value": 71.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 92.0, 70.0, 69.0, 67.0, 87.0, 67.0, 68.0, 90.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 85.0, 88.0, 85.0, 89.0, 85.0, 88.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 112.0, 148.0, 120.0, 93.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 103.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 79.0, 78.0, 84.0, 83.0, 85.0, 83.0, 81.0, 81.0], "value": 81.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 53.0, 56.0, 78.0, 65.0, 57.0, 56.0, 55.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 73.0, 72.0, 70.0, 67.0, 67.0, 68.0, 67.0, 67.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 81.0, 92.0, 100.0, 97.0, 79.0, 81.0, 81.0, 91.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 144.0, 132.0, 137.0, 139.0, 141.0, 141.0, 177.0, 129.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 163.0, 160.0, 159.0, 218.0, 218.0, 159.0, 165.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 64.0, 64.0, 64.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1436.6, "alertThreshold": 2.0}]} 14:42:11 INFO - Return code: 0 14:42:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:42:11 INFO - # TBPL SUCCESS # 14:42:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:42:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:42:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:42:11 INFO - 2017-02-10 14:42:11.880 screenresolution[1658:9787] starting screenresolution argv=screenresolution get 14:42:11 INFO - 2017-02-10 14:42:11.883 screenresolution[1658:9787] Display 0: 1600x1200x32@60 14:42:11 INFO - 2017-02-10 14:42:11.889 screenresolution[1659:9791] starting screenresolution argv=screenresolution list 14:42:11 INFO - Available Modes on Display 0 14:42:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:42:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:42:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:42:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:42:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:42:12 INFO - Intel Iris: 14:42:12 INFO - Chipset Model: Intel Iris 14:42:12 INFO - Type: GPU 14:42:12 INFO - Bus: Built-In 14:42:12 INFO - VRAM (Dynamic, Max): 1536 MB 14:42:12 INFO - Vendor: Intel (0x8086) 14:42:12 INFO - Device ID: 0x0a2e 14:42:12 INFO - Revision ID: 0x0009 14:42:12 INFO - Displays: 14:42:12 INFO - Display: 14:42:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:42:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:42:12 INFO - Display Serial Number: 1600x1200 60 14:42:12 INFO - Main Display: Yes 14:42:12 INFO - Mirror: Off 14:42:12 INFO - Online: Yes 14:42:12 INFO - Rotation: Supported 14:42:12 INFO - Return code: 0 14:42:12 INFO - Running post-action listener: _resource_record_post_action 14:42:12 INFO - [mozharness: 2017-02-10 22:42:12.129945Z] Finished run-tests step (success) 14:42:12 INFO - Running post-run listener: _resource_record_post_run 14:42:12 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 37938176; Write bytes: 501470720; Read time: 244; Write time: 1622 14:42:12 INFO - TinderboxPrint: CPU usage
53.7% 14:42:12 INFO - TinderboxPrint: I/O read bytes / time
37,938,176 / 244 14:42:12 INFO - TinderboxPrint: I/O write bytes / time
501,470,720 / 1,622 14:42:12 INFO - TinderboxPrint: CPU idle
2,219.5 (46.3%) 14:42:12 INFO - TinderboxPrint: CPU system
962.6 (20.1%) 14:42:12 INFO - TinderboxPrint: CPU user
1,611.5 (33.6%) 14:42:12 INFO - TinderboxPrint: Swap in / out
229,273,600 / 0 14:42:12 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183224832; Write bytes: 175607808; Read time: 16746; Write time: 397 14:42:12 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 37016576; Write bytes: 309179904; Read time: 233; Write time: 1172 14:42:12 INFO - Running post-run listener: _upload_blobber_files 14:42:12 INFO - Blob upload gear active. 14:42:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:42: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 14:42: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'] 14:42: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 14:42:13 INFO - (blobuploader) - INFO - Open directory for files ... 14:42:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:42:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:42:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:14 INFO - (blobuploader) - INFO - Done attempting. 14:42:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:42:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:42:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:15 INFO - (blobuploader) - INFO - Done attempting. 14:42:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:42:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:42:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:17 INFO - (blobuploader) - INFO - Done attempting. 14:42:17 INFO - (blobuploader) - INFO - Iteration through files over. 14:42:17 INFO - Return code: 0 14:42:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:42:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:42:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a208e072f56549e50d17a6bbad7a3ad694f79d518e45c8dcb66207022939bb3e673bb06afe30c3c64bde714adc744d396175695ae191de7fbb0fb104503a3287", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbda0e27462dff84425bc1ff5fc693788346766ec3c1b1745020bcb5e66416ab39f1447323123ca216d8f55ffbe1a22e893baa46d00aacd8a056042d233ea0c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4bb8cca85f2c15f765fbb0c026980b913fa651ee593682bcc36efe03b2db43efd34a85df73638e350898d1469975f52dcea5563e6ca66018cdc66e1d5d9834c2"} 14:42:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:42:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:42:17 INFO - Contents: 14:42:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a208e072f56549e50d17a6bbad7a3ad694f79d518e45c8dcb66207022939bb3e673bb06afe30c3c64bde714adc744d396175695ae191de7fbb0fb104503a3287", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbda0e27462dff84425bc1ff5fc693788346766ec3c1b1745020bcb5e66416ab39f1447323123ca216d8f55ffbe1a22e893baa46d00aacd8a056042d233ea0c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4bb8cca85f2c15f765fbb0c026980b913fa651ee593682bcc36efe03b2db43efd34a85df73638e350898d1469975f52dcea5563e6ca66018cdc66e1d5d9834c2"} 14:42:17 INFO - Running post-run listener: copy_logs_to_upload_dir 14:42:17 INFO - Copying logs to upload dir... 14:42:17 INFO - mkdir: /builds/slave/test/build/upload/logs 14:42:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.111017 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-10 14:42:17.193559) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 14:42:17.196824) ========= 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.SeQe1xRET8/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.nkeJCPNOzc/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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/a208e072f56549e50d17a6bbad7a3ad694f79d518e45c8dcb66207022939bb3e673bb06afe30c3c64bde714adc744d396175695ae191de7fbb0fb104503a3287", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbda0e27462dff84425bc1ff5fc693788346766ec3c1b1745020bcb5e66416ab39f1447323123ca216d8f55ffbe1a22e893baa46d00aacd8a056042d233ea0c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4bb8cca85f2c15f765fbb0c026980b913fa651ee593682bcc36efe03b2db43efd34a85df73638e350898d1469975f52dcea5563e6ca66018cdc66e1d5d9834c2"} build_url:https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011060 build_url: 'https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/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/a208e072f56549e50d17a6bbad7a3ad694f79d518e45c8dcb66207022939bb3e673bb06afe30c3c64bde714adc744d396175695ae191de7fbb0fb104503a3287", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbda0e27462dff84425bc1ff5fc693788346766ec3c1b1745020bcb5e66416ab39f1447323123ca216d8f55ffbe1a22e893baa46d00aacd8a056042d233ea0c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4bb8cca85f2c15f765fbb0c026980b913fa651ee593682bcc36efe03b2db43efd34a85df73638e350898d1469975f52dcea5563e6ca66018cdc66e1d5d9834c2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 14:42:17.234870) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:42:17.235659) ========= 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.SeQe1xRET8/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.nkeJCPNOzc/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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.005258 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:42:17.372619) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 14:42:17.372989) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 14:42:17.373518) ========= ========= Total master_lag: 0.30 =========