builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0092 starttime: 1477278980.93 results: success (0) buildid: 20161023170622 builduid: b585e8e56e64460e9c51d3ac4d3bdbb5 revision: 215f9686117673a2c914ed207bc7da9bb8d741ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 20:16:20.933604) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 20:16:20.934034) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 20:16:20.934321) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 20:16:20.958985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 20:16:20.959404) ========= 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.rvnfa2RrzO/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.tZGZX4E2d4/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-23 20:16:20-- 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% 171M=0s 2016-10-23 20:16:21 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.161592 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 20:16:21.143565) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 20:16:21.143889) ========= 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.rvnfa2RrzO/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.tZGZX4E2d4/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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.026004 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 20:16:21.192124) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-23 20:16:21.192489) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 215f9686117673a2c914ed207bc7da9bb8d741ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 215f9686117673a2c914ed207bc7da9bb8d741ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rvnfa2RrzO/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.tZGZX4E2d4/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-23 20:16:21,267 truncating revision to first 12 chars 2016-10-23 20:16:21,267 Setting DEBUG logging. 2016-10-23 20:16:21,267 attempt 1/10 2016-10-23 20:16:21,267 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/215f96861176?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-23 20:16:22,193 unpacking tar archive at: fx-team-215f96861176/testing/mozharness/ program finished with exit code 0 elapsedTime=1.207152 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-23 20:16:22.423040) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 20:16:22.423580) ========= script_repo_revision: 215f9686117673a2c914ed207bc7da9bb8d741ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 20:16:22.424201) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 20:16:22.424629) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 20:16:22.443413) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-23 20:16:22.443827) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rvnfa2RrzO/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.tZGZX4E2d4/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 20:16:22 INFO - MultiFileLogger online at 20161023 20:16:22 in /builds/slave/test 20:16:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:16:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:16:22 INFO - {'append_to_log': False, 20:16:22 INFO - 'base_work_dir': '/builds/slave/test', 20:16:22 INFO - 'blob_upload_branch': 'Fx-Team', 20:16:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:16:22 INFO - 'branch': 'Fx-Team', 20:16:22 INFO - 'buildbot_json_path': 'buildprops.json', 20:16:22 INFO - 'config_files': ('talos/mac_config.py',), 20:16:22 INFO - 'default_actions': ('clobber', 20:16:22 INFO - 'read-buildbot-config', 20:16:22 INFO - 'download-and-extract', 20:16:22 INFO - 'populate-webroot', 20:16:22 INFO - 'create-virtualenv', 20:16:22 INFO - 'install', 20:16:22 INFO - 'run-tests'), 20:16:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:16:22 INFO - 'download_minidump_stackwalk': True, 20:16:22 INFO - 'download_symbols': 'ondemand', 20:16:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:16:22 INFO - 'tooltool.py': '/tools/tooltool.py', 20:16:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:16:22 INFO - '/tools/misc-python/virtualenv.py')}, 20:16:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:16:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:16:22 INFO - 'installer_path': 'installer.exe', 20:16:22 INFO - 'log_level': 'info', 20:16:22 INFO - 'log_name': 'talos', 20:16:22 INFO - 'log_to_console': True, 20:16:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:16:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:16:22 INFO - 'opt_config_files': (), 20:16:22 INFO - 'pip_index': False, 20:16:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:16:22 INFO - 'cmd': ('bash', 20:16:22 INFO - '-c', 20:16:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:16:22 INFO - 'enabled': True, 20:16:22 INFO - 'halt_on_failure': False, 20:16:22 INFO - 'name': 'check_screen_resolution'},), 20:16:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:16:22 INFO - 'cmd': ('bash', 20:16:22 INFO - '-c', 20:16:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:16:22 INFO - 'enabled': True, 20:16:22 INFO - 'halt_on_failure': False, 20:16:22 INFO - 'name': 'check_screen_resolution'},), 20:16:22 INFO - 'run_cmd_checks_enabled': True, 20:16:22 INFO - 'sps_profile': False, 20:16:22 INFO - 'sps_profile_interval': 0, 20:16:22 INFO - 'suite': 'dromaeojs-e10s', 20:16:22 INFO - 'system_bits': '32', 20:16:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:16:22 INFO - 'title': 't-yosemite-r7-0092', 20:16:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:16:22 INFO - 'use_talos_json': True, 20:16:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:16:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:16:22 INFO - 'work_dir': 'build'} 20:16:22 INFO - [mozharness: 2016-10-24 03:16:22.642670Z] Running clobber step. 20:16:22 INFO - Running pre-action listener: _resource_record_pre_action 20:16:22 INFO - Running main action method: clobber 20:16:22 INFO - rmtree: /builds/slave/test/build 20:16:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:16:24 INFO - Running post-action listener: _resource_record_post_action 20:16:24 INFO - [mozharness: 2016-10-24 03:16:24.900824Z] Finished clobber step (success) 20:16:24 INFO - [mozharness: 2016-10-24 03:16:24.900954Z] Running read-buildbot-config step. 20:16:24 INFO - Running pre-action listener: _resource_record_pre_action 20:16:24 INFO - Running main action method: read_buildbot_config 20:16:24 INFO - Using buildbot properties: 20:16:24 INFO - { 20:16:24 INFO - "project": "", 20:16:24 INFO - "product": "firefox", 20:16:24 INFO - "script_repo_revision": "production", 20:16:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 20:16:24 INFO - "repository": "", 20:16:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 20:16:24 INFO - "buildid": "20161023170622", 20:16:24 INFO - "pgo_build": "False", 20:16:24 INFO - "basedir": "/builds/slave/test", 20:16:24 INFO - "buildnumber": 15, 20:16:24 INFO - "slavename": "t-yosemite-r7-0092", 20:16:24 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:16:24 INFO - "platform": "yosemite_r7", 20:16:24 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 20:16:24 INFO - "branch": "fx-team", 20:16:24 INFO - "repo_path": "integration/fx-team", 20:16:24 INFO - "revision": "215f9686117673a2c914ed207bc7da9bb8d741ad", 20:16:24 INFO - "stage_platform": "macosx64", 20:16:24 INFO - "builduid": "b585e8e56e64460e9c51d3ac4d3bdbb5", 20:16:24 INFO - "slavebuilddir": "test" 20:16:24 INFO - } 20:16:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 20:16:24 INFO - Running post-action listener: _resource_record_post_action 20:16:24 INFO - [mozharness: 2016-10-24 03:16:24.904421Z] Finished read-buildbot-config step (success) 20:16:24 INFO - [mozharness: 2016-10-24 03:16:24.904552Z] Running download-and-extract step. 20:16:24 INFO - Running pre-action listener: _resource_record_pre_action 20:16:24 INFO - Running main action method: download_and_extract 20:16:24 INFO - mkdir: /builds/slave/test/build/tests 20:16:24 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')]} 20:16:24 INFO - trying https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 20:16:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 20:16:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 20:16:26 INFO - Downloaded 1199 bytes. 20:16:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 20:16:26 INFO - Using the following test package requirements: 20:16:26 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:16:26 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:16:26 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 20:16:26 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:16:26 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 20:16:26 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:16:26 INFO - u'jsshell-mac.zip'], 20:16:26 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:16:26 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 20:16:26 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:16:26 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:16:26 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 20:16:26 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:16:26 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 20:16:26 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:16:26 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 20:16:26 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:16:26 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 20:16:26 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:16:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:16:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:16:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:16:26 INFO - Http code: 200 20:16:26 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 20:16:26 INFO - x-amz-cf-id: EBuyI40Ov_9wUE_DgYH-CcMtD9m6tlrZMjQDixuNF3lWyMjYHdckHA== 20:16:26 INFO - x-amz-version-id: BOJpiaP_s2AW6rojQaFtoF5wuOXcFT7C 20:16:27 INFO - Expected file size: 16409429 20:16:27 INFO - Obtained file size: 16409429 20:16:33 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:16:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:16:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:16:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:16:34 INFO - Http code: 200 20:16:34 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 20:16:34 INFO - x-amz-cf-id: Q98Pl0MPcSLxFzvD7pNEr3yaOl-1ORg9PEMtPwq4OGhvr7A73rMoog== 20:16:34 INFO - x-amz-version-id: BOJpiaP_s2AW6rojQaFtoF5wuOXcFT7C 20:16:34 INFO - Expected file size: 16409429 20:16:34 INFO - Obtained file size: 16409429 20:16:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 20:16:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:16:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 20:16:42 INFO - Http code: 200 20:16:42 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 20:16:42 INFO - x-amz-cf-id: KldLqAZCuGSslGC3w2IGdkHminbSm6Kka_b71bjmiLq8kgv9zawLmQ== 20:16:42 INFO - x-amz-version-id: lnQfvW0F07uoK7nWBQ5doN6W2C4WiMxF 20:16:42 INFO - Expected file size: 14409028 20:16:42 INFO - Obtained file size: 14409028 20:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:42 INFO - trying https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:16:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 20:16:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 20:16:45 INFO - Downloaded 111184849 bytes. 20:16:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:16:45 INFO - mkdir: /builds/slave/test/properties 20:16:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:16:45 INFO - Writing to file /builds/slave/test/properties/build_url 20:16:45 INFO - Contents: 20:16:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:16:46 INFO - Running post-action listener: _resource_record_post_action 20:16:46 INFO - Running post-action listener: set_extra_try_arguments 20:16:46 INFO - [mozharness: 2016-10-24 03:16:46.270441Z] Finished download-and-extract step (success) 20:16:46 INFO - [mozharness: 2016-10-24 03:16:46.270568Z] Running populate-webroot step. 20:16:46 INFO - Running pre-action listener: _resource_record_pre_action 20:16:46 INFO - Running main action method: populate_webroot 20:16:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:16:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:16:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:16:46 INFO - '--tppagecycles', 20:16:46 INFO - '7'], 20:16:46 INFO - 'tests': ['tsvgm']}}, 20:16:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:16:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:16:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:16:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:16:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:16:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:16:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:46 INFO - 'talos_options': ['--disable-e10s'], 20:16:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:46 INFO - 'talos_options': ['--disable-e10s'], 20:16:46 INFO - 'tests': ['damp', 'tps']}, 20:16:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:46 INFO - 'tests': ['damp', 'tps']}, 20:16:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:16:46 INFO - 'tests': ['dromaeo_dom']}, 20:16:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:16:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:16:46 INFO - 'tests': ['basic_compositor_video']}, 20:16:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:16:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:16:46 INFO - 'tests': ['a11yr', 20:16:46 INFO - 'ts_paint', 20:16:46 INFO - 'tpaint', 20:16:46 INFO - 'sessionrestore', 20:16:46 INFO - 'sessionrestore_no_auto_restore', 20:16:46 INFO - 'tabpaint']}, 20:16:46 INFO - 'other-e10s': {'tests': ['a11yr', 20:16:46 INFO - 'ts_paint', 20:16:46 INFO - 'tpaint', 20:16:46 INFO - 'sessionrestore', 20:16:46 INFO - 'sessionrestore_no_auto_restore', 20:16:46 INFO - 'tabpaint']}, 20:16:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:16:46 INFO - 'ts_paint', 20:16:46 INFO - 'tpaint', 20:16:46 INFO - 'sessionrestore', 20:16:46 INFO - 'sessionrestore_no_auto_restore', 20:16:46 INFO - 'tabpaint']}, 20:16:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:16:46 INFO - 'ts_paint', 20:16:46 INFO - 'tpaint', 20:16:46 INFO - 'sessionrestore', 20:16:46 INFO - 'sessionrestore_no_auto_restore', 20:16:46 INFO - 'tabpaint']}, 20:16:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:16:46 INFO - 'tests': ['a11yr', 20:16:46 INFO - 'ts_paint', 20:16:46 INFO - 'tpaint', 20:16:46 INFO - 'sessionrestore', 20:16:46 INFO - 'sessionrestore_no_auto_restore', 20:16:46 INFO - 'tabpaint']}, 20:16:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:16:46 INFO - 'tests': ['a11yr', 20:16:46 INFO - 'ts_paint', 20:16:46 INFO - 'tpaint', 20:16:46 INFO - 'sessionrestore', 20:16:46 INFO - 'sessionrestore_no_auto_restore', 20:16:46 INFO - 'tabpaint']}, 20:16:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:16:46 INFO - 'tests': ['tsvgx', 20:16:46 INFO - 'tsvgr_opacity', 20:16:46 INFO - 'tart', 20:16:46 INFO - 'tscrollx', 20:16:46 INFO - 'cart']}, 20:16:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:16:46 INFO - 'tsvgr_opacity', 20:16:46 INFO - 'tart', 20:16:46 INFO - 'tscrollx', 20:16:46 INFO - 'cart']}, 20:16:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:46 INFO - 'talos_options': ['--disable-e10s'], 20:16:46 INFO - 'tests': ['tp5o']}, 20:16:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:46 INFO - 'tests': ['tp5o']}, 20:16:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:46 INFO - 'talos_options': ['--disable-e10s', 20:16:46 INFO - '--xperf_path', 20:16:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:46 INFO - 'tests': ['tp5n']}, 20:16:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:46 INFO - 'talos_options': ['--xperf_path', 20:16:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:46 INFO - 'tests': ['tp5n']}}, 20:16:46 INFO - 'talos.zip': {'path': '', 20:16:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:16:46 INFO - Running post-action listener: _resource_record_post_action 20:16:46 INFO - [mozharness: 2016-10-24 03:16:46.289211Z] Finished populate-webroot step (success) 20:16:46 INFO - [mozharness: 2016-10-24 03:16:46.289343Z] Running create-virtualenv step. 20:16:46 INFO - Running pre-action listener: _resource_record_pre_action 20:16:46 INFO - Running main action method: create_virtualenv 20:16:46 INFO - Creating virtualenv /builds/slave/test/build/venv 20:16:46 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 20:16:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:16:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:16:46 INFO - Using real prefix '/tools/python27' 20:16:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:16:47 INFO - Installing distribute.............................................................................................................................................................................................done. 20:16:49 INFO - Installing pip.................done. 20:16:49 INFO - Return code: 0 20:16:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:16:50 INFO - Reading from file tmpfile_stdout 20:16:50 INFO - Output received: 20:16:50 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) 20:16:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:16:50 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')]} 20:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:50 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')]} 20:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc728ca4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d83d30>, '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 0x109ba9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7bb20>, '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.rvnfa2RrzO/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.tZGZX4E2d4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 20:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:16:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rvnfa2RrzO/Render', 20:16:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:16:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:16:50 INFO - 'HOME': '/Users/cltbld', 20:16:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:16:50 INFO - 'LOGNAME': 'cltbld', 20:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:50 INFO - 'MOZ_NO_REMOTE': '1', 20:16:50 INFO - 'NO_EM_RESTART': '1', 20:16:50 INFO - 'PAGER': '/bin/cat', 20:16:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:50 INFO - 'PWD': '/builds/slave/test', 20:16:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:16:50 INFO - 'SHELL': '/bin/bash', 20:16:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZGZX4E2d4/Listeners', 20:16:50 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 20:16:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:16:50 INFO - 'USER': 'cltbld', 20:16:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:16:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:50 INFO - 'XPC_FLAGS': '0x0', 20:16:50 INFO - 'XPC_SERVICE_NAME': '0', 20:16:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:50 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 20:16:50 INFO - Cleaning up... 20:16:50 INFO - Return code: 0 20:16:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:16:50 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')]} 20:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:50 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')]} 20:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109f6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc728ca4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d83d30>, '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 0x109ba9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7bb20>, '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.rvnfa2RrzO/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.tZGZX4E2d4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 20:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:16:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rvnfa2RrzO/Render', 20:16:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:16:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:16:50 INFO - 'HOME': '/Users/cltbld', 20:16:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:16:50 INFO - 'LOGNAME': 'cltbld', 20:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:50 INFO - 'MOZ_NO_REMOTE': '1', 20:16:50 INFO - 'NO_EM_RESTART': '1', 20:16:50 INFO - 'PAGER': '/bin/cat', 20:16:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:50 INFO - 'PWD': '/builds/slave/test', 20:16:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:16:50 INFO - 'SHELL': '/bin/bash', 20:16:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZGZX4E2d4/Listeners', 20:16:50 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 20:16:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:16:50 INFO - 'USER': 'cltbld', 20:16:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:16:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:50 INFO - 'XPC_FLAGS': '0x0', 20:16:50 INFO - 'XPC_SERVICE_NAME': '0', 20:16:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:50 INFO - Downloading/unpacking psutil>=3.1.1 20:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:16:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:54 INFO - Installing collected packages: psutil 20:16:54 INFO - Running setup.py install for psutil 20:16:54 INFO - building 'psutil._psutil_osx' extension 20:16:54 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 20:16:54 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 20:16:54 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 20:16:54 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 20:16:55 INFO - building 'psutil._psutil_posix' extension 20:16:55 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 20:16:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:16:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:16:55 INFO - ^ 20:16:55 INFO - 1 warning generated. 20:16:55 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 20:16:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:55 INFO - Successfully installed psutil 20:16:55 INFO - Cleaning up... 20:16:55 INFO - Return code: 0 20:16:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:16: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')]} 20:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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')]} 20:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc728ca4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d83d30>, '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 0x109ba9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7bb20>, '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.rvnfa2RrzO/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.tZGZX4E2d4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 20:16: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:16: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 mozsystemmonitor==0.3 20:16:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rvnfa2RrzO/Render', 20:16:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:16:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:16:55 INFO - 'HOME': '/Users/cltbld', 20:16:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:16:55 INFO - 'LOGNAME': 'cltbld', 20:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:55 INFO - 'MOZ_NO_REMOTE': '1', 20:16:55 INFO - 'NO_EM_RESTART': '1', 20:16:55 INFO - 'PAGER': '/bin/cat', 20:16:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:55 INFO - 'PWD': '/builds/slave/test', 20:16:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:16:55 INFO - 'SHELL': '/bin/bash', 20:16:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZGZX4E2d4/Listeners', 20:16:55 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 20:16:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:16:55 INFO - 'USER': 'cltbld', 20:16:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:16:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:55 INFO - 'XPC_FLAGS': '0x0', 20:16:55 INFO - 'XPC_SERVICE_NAME': '0', 20:16:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:16: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 20:16: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 20:16: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 20:16: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 20:16: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 20:16: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 20:16:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:16:58 INFO - Installing collected packages: mozsystemmonitor 20:16:58 INFO - Running setup.py install for mozsystemmonitor 20:16:58 INFO - Successfully installed mozsystemmonitor 20:16:58 INFO - Cleaning up... 20:16:58 INFO - Return code: 0 20:16:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:16:58 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')]} 20:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:58 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')]} 20:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:58 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 0x109f6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc728ca4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d83d30>, '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 0x109ba9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7bb20>, '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.rvnfa2RrzO/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.tZGZX4E2d4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 20:16:58 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 20:16:58 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 20:16:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rvnfa2RrzO/Render', 20:16:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:16:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:16:58 INFO - 'HOME': '/Users/cltbld', 20:16:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:16:58 INFO - 'LOGNAME': 'cltbld', 20:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:58 INFO - 'MOZ_NO_REMOTE': '1', 20:16:58 INFO - 'NO_EM_RESTART': '1', 20:16:58 INFO - 'PAGER': '/bin/cat', 20:16:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:58 INFO - 'PWD': '/builds/slave/test', 20:16:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:16:58 INFO - 'SHELL': '/bin/bash', 20:16:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZGZX4E2d4/Listeners', 20:16:58 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 20:16:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:16:58 INFO - 'USER': 'cltbld', 20:16:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:16:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:58 INFO - 'XPC_FLAGS': '0x0', 20:16:58 INFO - 'XPC_SERVICE_NAME': '0', 20:16:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:58 INFO - Downloading/unpacking jsonschema==2.5.1 20:16:58 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 20:16:58 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 20:16:58 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 20:16:58 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 20:16:58 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 20:16:58 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 20:17:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:17:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:17:01 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 20:17:01 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 20:17:01 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 20:17:01 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 20:17:01 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 20:17:01 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 20:17:01 INFO - Downloading functools32-3.2.3-2.tar.gz 20:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:17:01 INFO - warning: no files found matching '*.txt' 20:17:01 INFO - no previously-included directories found matching 'build' 20:17:01 INFO - no previously-included directories found matching 'dist' 20:17:01 INFO - no previously-included directories found matching '.git*' 20:17:01 INFO - Installing collected packages: jsonschema, functools32 20:17:01 INFO - Running setup.py install for functools32 20:17:01 INFO - warning: no files found matching '*.txt' 20:17:01 INFO - no previously-included directories found matching 'build' 20:17:01 INFO - no previously-included directories found matching 'dist' 20:17:01 INFO - no previously-included directories found matching '.git*' 20:17:01 INFO - Successfully installed jsonschema functools32 20:17:01 INFO - Cleaning up... 20:17:02 INFO - Return code: 0 20:17:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:02 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 0x109f6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc728ca4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d83d30>, '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 0x109ba9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7bb20>, '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.rvnfa2RrzO/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.tZGZX4E2d4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 20:17:02 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 20:17:02 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 20:17:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rvnfa2RrzO/Render', 20:17:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:02 INFO - 'HOME': '/Users/cltbld', 20:17:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:02 INFO - 'LOGNAME': 'cltbld', 20:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:02 INFO - 'MOZ_NO_REMOTE': '1', 20:17:02 INFO - 'NO_EM_RESTART': '1', 20:17:02 INFO - 'PAGER': '/bin/cat', 20:17:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:02 INFO - 'PWD': '/builds/slave/test', 20:17:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:02 INFO - 'SHELL': '/bin/bash', 20:17:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZGZX4E2d4/Listeners', 20:17:02 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 20:17:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:02 INFO - 'USER': 'cltbld', 20:17:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:02 INFO - 'XPC_FLAGS': '0x0', 20:17:02 INFO - 'XPC_SERVICE_NAME': '0', 20:17:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:17:02 INFO - Cleaning up... 20:17:02 INFO - Return code: 0 20:17:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:02 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 0x109f6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc728ca4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d83d30>, '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 0x109ba9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7bb20>, '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.rvnfa2RrzO/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.tZGZX4E2d4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 20:17:02 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 20:17:02 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 20:17:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rvnfa2RrzO/Render', 20:17:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:02 INFO - 'HOME': '/Users/cltbld', 20:17:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:02 INFO - 'LOGNAME': 'cltbld', 20:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:02 INFO - 'MOZ_NO_REMOTE': '1', 20:17:02 INFO - 'NO_EM_RESTART': '1', 20:17:02 INFO - 'PAGER': '/bin/cat', 20:17:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:02 INFO - 'PWD': '/builds/slave/test', 20:17:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:02 INFO - 'SHELL': '/bin/bash', 20:17:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZGZX4E2d4/Listeners', 20:17:02 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 20:17:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:02 INFO - 'USER': 'cltbld', 20:17:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:02 INFO - 'XPC_FLAGS': '0x0', 20:17:02 INFO - 'XPC_SERVICE_NAME': '0', 20:17:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:02 INFO - Downloading/unpacking blobuploader==1.2.4 20:17:02 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 20:17:02 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 20:17:02 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 20:17:02 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 20:17:02 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 20:17:02 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 20:17:04 INFO - Downloading blobuploader-1.2.4.tar.gz 20:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:17:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:17:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:06 INFO - Downloading docopt-0.6.1.tar.gz 20:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:17:06 INFO - Installing collected packages: blobuploader, requests, docopt 20:17:06 INFO - Running setup.py install for blobuploader 20:17:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:17:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:17:06 INFO - Running setup.py install for requests 20:17:06 INFO - Running setup.py install for docopt 20:17:07 INFO - Successfully installed blobuploader requests docopt 20:17:07 INFO - Cleaning up... 20:17:07 INFO - Return code: 0 20:17:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17:07 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')]} 20:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:07 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')]} 20:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:07 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 0x109f6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc728ca4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d83d30>, '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 0x109ba9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7bb20>, '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.rvnfa2RrzO/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.tZGZX4E2d4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 20:17:07 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 20:17:07 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 20:17:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rvnfa2RrzO/Render', 20:17:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:07 INFO - 'HOME': '/Users/cltbld', 20:17:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:07 INFO - 'LOGNAME': 'cltbld', 20:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:07 INFO - 'MOZ_NO_REMOTE': '1', 20:17:07 INFO - 'NO_EM_RESTART': '1', 20:17:07 INFO - 'PAGER': '/bin/cat', 20:17:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:07 INFO - 'PWD': '/builds/slave/test', 20:17:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:07 INFO - 'SHELL': '/bin/bash', 20:17:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZGZX4E2d4/Listeners', 20:17:07 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 20:17:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:07 INFO - 'USER': 'cltbld', 20:17:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:07 INFO - 'XPC_FLAGS': '0x0', 20:17:07 INFO - 'XPC_SERVICE_NAME': '0', 20:17:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:17:07 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-9R9WWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:17:07 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-wRBKrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:17:07 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-ZtjT8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:17:07 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-6U6lpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:17:07 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-zYqOzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:17:07 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-NEA_eH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:17:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-2yzi0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:17:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-WrZXBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:17:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-OHdHHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:17:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-92wrCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:17:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-EmH6SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:17:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-cc_5G8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:17:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-OazrdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:17:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-48boDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-UNewqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:17:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-zd_83u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:17:09 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-SdF3Cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:17:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:17:09 INFO - Running setup.py install for manifestparser 20:17:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Running setup.py install for mozcrash 20:17:09 INFO - Running setup.py install for mozdebug 20:17:09 INFO - Running setup.py install for mozdevice 20:17:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Running setup.py install for mozfile 20:17:09 INFO - Running setup.py install for mozhttpd 20:17:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Running setup.py install for mozinfo 20:17:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Running setup.py install for mozInstall 20:17:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Running setup.py install for mozleak 20:17:10 INFO - Running setup.py install for mozlog 20:17:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Running setup.py install for moznetwork 20:17:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Running setup.py install for mozprocess 20:17:10 INFO - Running setup.py install for mozprofile 20:17:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:17:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:17:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:17:11 INFO - Running setup.py install for mozrunner 20:17:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:17:11 INFO - Running setup.py install for mozscreenshot 20:17:11 INFO - Running setup.py install for moztest 20:17:11 INFO - Running setup.py install for mozversion 20:17:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:17:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:17:11 INFO - Cleaning up... 20:17:11 INFO - Return code: 0 20:17:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17:11 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')]} 20:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:11 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')]} 20:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:11 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 0x109f6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc728ca4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d83d30>, '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 0x109ba9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7bb20>, '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.rvnfa2RrzO/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.tZGZX4E2d4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 20:17:11 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 20:17:11 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 20:17:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rvnfa2RrzO/Render', 20:17:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:11 INFO - 'HOME': '/Users/cltbld', 20:17:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:11 INFO - 'LOGNAME': 'cltbld', 20:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:11 INFO - 'MOZ_NO_REMOTE': '1', 20:17:11 INFO - 'NO_EM_RESTART': '1', 20:17:11 INFO - 'PAGER': '/bin/cat', 20:17:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:11 INFO - 'PWD': '/builds/slave/test', 20:17:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:11 INFO - 'SHELL': '/bin/bash', 20:17:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZGZX4E2d4/Listeners', 20:17:11 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 20:17:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:11 INFO - 'USER': 'cltbld', 20:17:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:11 INFO - 'XPC_FLAGS': '0x0', 20:17:11 INFO - 'XPC_SERVICE_NAME': '0', 20:17:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:17:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-0PldGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:17:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-idMmWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:17:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-hZcVC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:17:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-JWhYV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:17:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-BR38sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:17:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-EHevUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:17:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-Gps6dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:17:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-9bIuSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:17:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-mBMmeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:17:13 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)) 20:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:17:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-VINUTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:17:13 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)) 20:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:17:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-T6WiSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:17:13 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)) 20:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:17:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-qDuFPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:17:13 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)) 20:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:17:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-Lq_t9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:17:13 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)) 20:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:17:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-gDKyzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 20:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-UPDJAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:13 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)) 20:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:17:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-MX9F1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:17:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-R4L9Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:17:13 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)) 20:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:17:13 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)) 20:17:13 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)) 20:17:13 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)) 20:17:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:17:13 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 20:17:13 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 20:17:13 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 20:17:13 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 20:17:13 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 20:17:13 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 20:17:16 INFO - Downloading blessings-1.6.tar.gz 20:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:17:16 INFO - Installing collected packages: blessings 20:17:16 INFO - Running setup.py install for blessings 20:17:16 INFO - Successfully installed blessings 20:17:16 INFO - Cleaning up... 20:17:16 INFO - Return code: 0 20:17:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:17:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:17:17 INFO - Reading from file tmpfile_stdout 20:17:17 INFO - Current package versions: 20:17:17 INFO - blessings == 1.6 20:17:17 INFO - blobuploader == 1.2.4 20:17:17 INFO - docopt == 0.6.1 20:17:17 INFO - functools32 == 3.2.3-2 20:17:17 INFO - jsonschema == 2.5.1 20:17:17 INFO - manifestparser == 1.1 20:17:17 INFO - mozInstall == 1.12 20:17:17 INFO - mozcrash == 0.17 20:17:17 INFO - mozdebug == 0.1 20:17:17 INFO - mozdevice == 0.48 20:17:17 INFO - mozfile == 1.2 20:17:17 INFO - mozhttpd == 0.7 20:17:17 INFO - mozinfo == 0.9 20:17:17 INFO - mozleak == 0.1 20:17:17 INFO - mozlog == 3.4 20:17:17 INFO - moznetwork == 0.27 20:17:17 INFO - mozprocess == 0.23 20:17:17 INFO - mozprofile == 0.28 20:17:17 INFO - mozrunner == 6.12 20:17:17 INFO - mozscreenshot == 0.1 20:17:17 INFO - mozsystemmonitor == 0.3 20:17:17 INFO - moztest == 0.7 20:17:17 INFO - mozversion == 1.4 20:17:17 INFO - psutil == 3.1.1 20:17:17 INFO - requests == 1.2.3 20:17:17 INFO - wsgiref == 0.1.2 20:17:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17:17 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')]} 20:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:17 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')]} 20:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:17 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 0x109f6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc728ca4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d83d30>, '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 0x109ba9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7bb20>, '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.rvnfa2RrzO/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.tZGZX4E2d4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 20:17:17 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 20:17:17 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 20:17:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rvnfa2RrzO/Render', 20:17:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:17 INFO - 'HOME': '/Users/cltbld', 20:17:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:17 INFO - 'LOGNAME': 'cltbld', 20:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:17 INFO - 'MOZ_NO_REMOTE': '1', 20:17:17 INFO - 'NO_EM_RESTART': '1', 20:17:17 INFO - 'PAGER': '/bin/cat', 20:17:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:17 INFO - 'PWD': '/builds/slave/test', 20:17:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:17 INFO - 'SHELL': '/bin/bash', 20:17:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZGZX4E2d4/Listeners', 20:17:17 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 20:17:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:17 INFO - 'USER': 'cltbld', 20:17:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:17 INFO - 'XPC_FLAGS': '0x0', 20:17:17 INFO - 'XPC_SERVICE_NAME': '0', 20:17:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:17 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)) 20:17:17 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)) 20:17:17 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)) 20:17:17 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)) 20:17:17 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)) 20:17:17 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)) 20:17:17 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)) 20:17:17 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)) 20:17:17 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)) 20:17:17 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)) 20:17:17 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)) 20:17:17 INFO - Cleaning up... 20:17:17 INFO - Return code: 0 20:17:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:17:17 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')]} 20:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:17 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')]} 20:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:17 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 0x109f6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc728ca4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d83d30>, '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 0x109ba9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7bb20>, '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.rvnfa2RrzO/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.tZGZX4E2d4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 20:17:17 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 20:17:17 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 20:17:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rvnfa2RrzO/Render', 20:17:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:17 INFO - 'HOME': '/Users/cltbld', 20:17:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:17 INFO - 'LOGNAME': 'cltbld', 20:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:17 INFO - 'MOZ_NO_REMOTE': '1', 20:17:17 INFO - 'NO_EM_RESTART': '1', 20:17:17 INFO - 'PAGER': '/bin/cat', 20:17:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:17 INFO - 'PWD': '/builds/slave/test', 20:17:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:17 INFO - 'SHELL': '/bin/bash', 20:17:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZGZX4E2d4/Listeners', 20:17:17 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 20:17:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:17 INFO - 'USER': 'cltbld', 20:17:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:17 INFO - 'XPC_FLAGS': '0x0', 20:17:17 INFO - 'XPC_SERVICE_NAME': '0', 20:17:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:17:17 INFO - Cleaning up... 20:17:17 INFO - Return code: 0 20:17:17 INFO - Running post-action listener: _resource_record_post_action 20:17:17 INFO - Running post-action listener: _start_resource_monitoring 20:17:17 INFO - Starting resource monitoring. 20:17:17 INFO - [mozharness: 2016-10-24 03:17:17.612633Z] Finished create-virtualenv step (success) 20:17:17 INFO - [mozharness: 2016-10-24 03:17:17.613430Z] Running install step. 20:17:17 INFO - Running pre-action listener: _resource_record_pre_action 20:17:17 INFO - Running main action method: install 20:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:17:17 INFO - Reading from file tmpfile_stdout 20:17:17 INFO - Detecting whether we're running mozinstall >=1.0... 20:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:17:17 INFO - Reading from file tmpfile_stdout 20:17:17 INFO - Output received: 20:17:17 INFO - Usage: mozinstall [options] installer 20:17:17 INFO - Options: 20:17:17 INFO - -h, --help show this help message and exit 20:17:17 INFO - -d DEST, --destination=DEST 20:17:17 INFO - Directory to install application into. [default: 20:17:17 INFO - "/builds/slave/test"] 20:17:17 INFO - --app=APP Application being installed. [default: firefox] 20:17:17 INFO - mkdir: /builds/slave/test/build/application 20:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:17:51 INFO - Reading from file tmpfile_stdout 20:17:51 INFO - Output received: 20:17:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:17:51 INFO - Running post-action listener: _resource_record_post_action 20:17:51 INFO - [mozharness: 2016-10-24 03:17:51.973723Z] Finished install step (success) 20:17:51 INFO - [mozharness: 2016-10-24 03:17:51.973864Z] Running run-tests step. 20:17:51 INFO - Running pre-action listener: _resource_record_pre_action 20:17:51 INFO - Running main action method: run_tests 20:17:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:17:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:17:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:17:51 INFO - 2016-10-23 20:17:51.988 screenresolution[1633:7433] starting screenresolution argv=screenresolution get 20:17:51 INFO - 2016-10-23 20:17:51.990 screenresolution[1633:7433] Display 0: 1600x1200x32@60 20:17:51 INFO - 2016-10-23 20:17:51.996 screenresolution[1634:7435] starting screenresolution argv=screenresolution list 20:17:51 INFO - Available Modes on Display 0 20:17:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:17:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:17:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:17:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:17:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:17:52 INFO - Intel Iris: 20:17:52 INFO - Chipset Model: Intel Iris 20:17:52 INFO - Type: GPU 20:17:52 INFO - Bus: Built-In 20:17:52 INFO - VRAM (Dynamic, Max): 1536 MB 20:17:52 INFO - Vendor: Intel (0x8086) 20:17:52 INFO - Device ID: 0x0a2e 20:17:52 INFO - Revision ID: 0x0009 20:17:52 INFO - Displays: 20:17:52 INFO - Display: 20:17:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:17:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:17:52 INFO - Display Serial Number: 1600x1200 60 20:17:52 INFO - Main Display: Yes 20:17:52 INFO - Mirror: Off 20:17:52 INFO - Online: Yes 20:17:52 INFO - Rotation: Supported 20:17:52 INFO - Return code: 0 20:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:17:52 INFO - Python 2.7.3 20:17:52 INFO - Return code: 0 20:17:52 INFO - grabbing minidump binary from tooltool 20:17: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')]} 20:17:52 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 0x109d83d30>, '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 0x109ba9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:17:52 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 20:17:52 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 20:17:52 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 20:17:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:17:52 INFO - Return code: 0 20:17:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:17:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:17:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:17:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:17:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0092', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0092 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:17:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rvnfa2RrzO/Render', 20:17:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:52 INFO - 'HOME': '/Users/cltbld', 20:17:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:52 INFO - 'LOGNAME': 'cltbld', 20:17:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:17:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:52 INFO - 'MOZ_NO_REMOTE': '1', 20:17:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:17:52 INFO - 'NO_EM_RESTART': '1', 20:17:52 INFO - 'PAGER': '/bin/cat', 20:17:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:52 INFO - 'PWD': '/builds/slave/test', 20:17:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:17:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:52 INFO - 'SHELL': '/bin/bash', 20:17:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZGZX4E2d4/Listeners', 20:17:52 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 20:17:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:52 INFO - 'USER': 'cltbld', 20:17:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:52 INFO - 'XPC_FLAGS': '0x0', 20:17:52 INFO - 'XPC_SERVICE_NAME': '0', 20:17:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0092', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:17:52 INFO - mozversion application_buildid: 20161023170622 20:17:52 INFO - mozversion application_changeset: 215f9686117673a2c914ed207bc7da9bb8d741ad 20:17:52 INFO - mozversion application_display_name: Nightly 20:17:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:17:52 INFO - mozversion application_name: Firefox 20:17:52 INFO - mozversion application_remotingname: firefox 20:17:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:17:52 INFO - mozversion application_vendor: Mozilla 20:17:52 INFO - mozversion application_version: 52.0a1 20:17:52 INFO - mozversion platform_buildid: 20161023170622 20:17:52 INFO - mozversion platform_changeset: 215f9686117673a2c914ed207bc7da9bb8d741ad 20:17:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:17:52 INFO - mozversion platform_version: 52.0a1 20:17:52 INFO - using testdate: 1477279072 20:17:52 INFO - actual date: 1477279072 20:17:52 INFO - starting webserver on 'localhost:49272' 20:17:52 INFO - SUITE-START | Running 2 tests 20:17:52 INFO - TEST-START | dromaeo_css 20:17:52 INFO - operating with platform_type : mac_ 20:17:52 INFO - Initialising browser for dromaeo_css test... 20:17:52 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpXsMRy5/profile http://localhost:49272/getInfo.html) 20:17:55 INFO - PROCESS | 1644 | 2016-10-23 20:17:55.254 plugin-container[1646:7601] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e37, name = 'com.apple.tsm.portname' 20:17:55 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:17:55 INFO - PROCESS | 1644 | 2016-10-23 20:17:55.257 plugin-container[1646:7601] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 20:17:55 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:17:55 INFO - PROCESS | 1644 | 2016-10-23 20:17:55.257 plugin-container[1646:7601] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:17:55 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 20:17:55 INFO - PROCESS | 1644 | colorDepth:24 20:17:55 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 20:17:55 INFO - PROCESS | 1644 | __metrics 20:17:55 ERROR - PROCESS | 1644 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 20:17:56 INFO - TEST-INFO | 1644: exit 0 20:17:56 INFO - Browser initialized. 20:17:56 INFO - Running cycle 1/1 for dromaeo_css test... 20:17:56 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpXsMRy5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:58 INFO - PROCESS | 1647 | 2016-10-23 20:17:58.424 plugin-container[1648:7725] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x884b, name = 'com.apple.tsm.portname' 20:17:58 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:17:58 INFO - PROCESS | 1647 | 2016-10-23 20:17:58.427 plugin-container[1648:7725] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 20:17:58 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:17:58 INFO - PROCESS | 1647 | 2016-10-23 20:17:58.427 plugin-container[1648:7725] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:18:08 INFO - PROCESS | 1647 | RSS: Main: 236806144 20:18:08 INFO - PROCESS | 1647 | 20:18:57 INFO - PROCESS | 1647 | 1477279137799 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:21:11 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 20:21:12 INFO - PROCESS | 1647 | RSS: Main: 249671680 20:21:12 INFO - PROCESS | 1647 | 20:24:15 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 20:24:15 INFO - PROCESS | 1647 | RSS: Main: 264544256 20:24:15 INFO - PROCESS | 1647 | 20:27:17 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 20:27:18 INFO - PROCESS | 1647 | RSS: Main: 269189120 20:27:18 INFO - PROCESS | 1647 | 20:30:20 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 20:30:20 INFO - PROCESS | 1647 | RSS: Main: 268931072 20:30:20 INFO - PROCESS | 1647 | 20:33:23 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 20:33:24 INFO - PROCESS | 1647 | RSS: Main: 274329600 20:33:24 INFO - PROCESS | 1647 | 20:36:26 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 20:36:27 INFO - PROCESS | 1647 | RSS: Main: 276910080 20:36:27 INFO - PROCESS | 1647 | 20:36:27 INFO - PROCESS | 1647 | __start_tp_report 20:36:27 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 20:36:27 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 20:36:27 INFO - PROCESS | 1647 | |i|pagename|runs| 20:36:27 INFO - PROCESS | 1647 | |0;dojo.html;3415.4876768484723;3427.2631384252395;3451.654834516547;3452.999999999999;3478.8608455661774;5619.943800561993;5761.798337058204;5799.420057994198;5817.650940943547;5842.386549412309;5476.397596264408;5651.2935883014625;5739.942600573993;5795.043817770063;5836.095405212188;5152.510511501401;5236.450172731866;5237.921431178535;5248.658837175591;5315.096433606296;4661.65037622178;5130.410002849664;5197.558207552363;5319.148936170213;5412.9458705413035;4218.725782824106;5244.973775131119;5253.842384728464;5290.206469029637;5298.470152984709;5106.463821298785;5174.793008279665;5177.8187763428095;5206.036883176586;5271.077561426735;5147.7683504242395;5149.176131818891;5179.067767801795;5184.533391994739;5189.584833213334;4356.695031347807;4503.03184815263;5417.51242388183;5743.655380677173;5766.509846662997;5173.896522069575;6078.574499785017;6098.60359076663;6158;6277.121203031534;6303.653299068549;6303.779367722108;6309.810705678837;6312.179416675849;6329.905051424233;5886.646801191942;5900.675462849542;5904.822855314347;5986.850328741816;6013.128096425994;6111.166351794787;6127.111568822495;6163.907541386883;6197.597156184834;6340.365963403715;6111.052786818051;6128.900367973304;6171.783987560414;6181.196444462191;6194;6089.512838972872;6181.443670069715;6196.47329976948;6202.72087756052;6212.627242365473;6086.756529738849;6110.346130329488;6158.322584515699;6167.537434692326;6281.874362512815;6248.218972628421;6289.8742025159245;6296.244450665949;6299;6315.873682526324;4885.560299572984;4943.060818444484;4944.357233559686;4948.158813001726;4975;4342.609165175149;4415.779211039435;4422.75674837887;4428.778561071934;4455.309427038814;5349.689326115126;5441.455854414606;5794.072948328248;5885.028970219952;5921.259842519685;5187.974060129675;6240.157578726905;6287.308396076428;6319.46284565817;6320;5632.831015069554;5756.942430575725;5825.592208545446;5850.736716847752;5872.17789509469;5346.625736198429;5375.408705042442;5389.973050134724;5418.674879507243;5457.972710136503;6309.022101574264;6316.178896743486;6318.210223721942;6321.810345689637;6330;6130.417610327012;6291.285632104097;6313.210848643919;6319.210098737658;6327.810165695037;6225.315215326401;6236.03341482071;6244.906326405198;6283.2774230962195;6292.937070629235;6242.531810114168;6260.530460215411;6263.843403914939;6267.780627678009;6268.028455589391;5965.582409231312;6099;6286.842828929313;6307.117003619405;6325.588836725598;5759.308882934075;6075.2405949256345;6109.526129009804;6121.326654068138;6178.351273116258;6087.659905928906;6129.08063790435;6139.938600613937;6152.292486364126;6177.104319873683;5814.970925145347;5871.6770577618645;5916.230889984275;6001.5798894077;6036.215292012011;6064.666443345658;6115.816525504242;6116.602420842631;6117.3402608778015;6142.590862071594;4967.726775027264;5977.701114944322;5989.311229208697;5993.520518358434;6013.158157857816 20:36:27 INFO - PROCESS | 1647 | |1;ext.html;452.57005844447775;472.9760069449642;524.2869697211794;546.0934848152067;562.8536580489072;33535;38380.848574542775;40474.79762601187;40566.99999999993;40663;41175.38236926441;41384.37923431143;41670.791646041806;41775.16449671005;41864.95337616561;9322.347435679489;9365.625374984993;9466.81066378672;9521.761955951122;9556.99651536589;9440.905590944072;9507.762305942337;9518.857217141749;9531.666391676292;9545.379550329206;9516.857247141299;9523.619055237818;9569.282303827205;9580.61677532898;9589.616415343378;9500.049995000514;9502.762430939212;9518.238540916711;9521.143097121223;9545.713628591153;9268.814623707556;9346;9350.064993500664;9377.1091746284;9389.483578403186;39201.803990980145;39301.41047884284;39302.017449563704;39318.213635727414;39395.803020985;3022.4710675631895;3277.705006549422;3462.5325581046486;3562.305350456662;3632.8365223565;30017.849910750305;31400.787543225102;31796;31803.88686395988;31842.363152736816;3186.952195717066;3193.680631936788;3245.983770081158;3335.4663253879507;3383.2218589724257;454506.72746636387;455012;458520;461333;464278;62501.37498624955;62913.68543157347;63034;63107;63182;65581.67209163924;65703;65929;66047.33952660508;66262;16006.599835003984;16173.353065877232;16203.513894583182;16212.270447829877;16218.837811621968;12389.256644601353;12420.503179872703;12470.563530276397;12523.436445359981;12575.679553646918;18461.461860187268;19273.51816204606;19320.903395482932;19347.903260483607;19404.708929366072;7953.602319883983;8100.878486822702;8106.675732970615;8139.877901831477;8187.590620468953;824.6371596497522;959.2326139088701;964.4888209249109;990.8563258327503;1051.5320682296458;29578.704212957597;29837.850810745807;30079.849600751855;30697.84651076775;30994.69005309963;909.486140330711;1013.7060252526832;1035.4615599888016;1078.2937176149635;1114.2979922648842;14854.331555080047;15273.465428709942;15685.843141568666;15882.682346353009;15932;616088;650899;655699;656217.7189114024;656647;57262;57578;57867.71066144642;57922.7103864478;58012.70993645089;1073.8831615120343;1160.4893846707253;1347.1041757231528;1369.5959691890716;1401.9579412617638;25979.350516237246;29010.274743130747;29789.702102978692;29844.403111938074;30372.84813575918;50346;50427.74786126046;50935.235971461196;50972.23541646953;51080.72298192575;475951;554638;558929;561662;561735;26481.205563833115;26817.731822681522;26853.865730671223;26877.731222688304;26882.059127930428;46290.53709462862;46778;46907.53092469032;47976;48016.27975580299;32611.836940815145;39319.82040538789;41136;41526.37710434286;42120;32949.50575741318;38340;38633.80683096567;39333.80333098316;39508.2098358037;32499;37961.43057854079;38016.85949421522;38340.80829595834;40524.79737601293;32048.839755801073;34645.13387165341;35039.82480087583;35383.64616353803;35431;25154.62268065944;25289.62065569055;25384.41335771367;25764.484710305314;25768.09811656583 20:36:27 INFO - PROCESS | 1647 | |2;jquery.html;288.46345796817917;369.4107897902846;372.71301098154424;384.46751249519406;402.9617186367294;19171.808281917176;19652.606947861033;20447;20799;21069.473263168427;19436.70844937327;19787.505312367197;20761.792382076175;20940.68588971163;20947.476313092182;5822.883542329151;5875.794347197849;6019.277686677605;6034.426729460716;6083.209182806229;5908.822735317925;5937.554683398741;6003.649178934748;6031;6046.365131661179;5634;5886.234789477362;5926.940730592682;5973.581849270553;5994.280686317648;5897.498712609433;5954.374790646984;6006.339302676702;6008.669523176223;6021.066734656135;5108.489151084862;5186.273921650972;5352.411234764173;5428.782848686048;5480.671159730429;12482.50069997208;12697.428615712315;12705.491780328775;12922;12922.28927408992;2049.3749406431034;2062.267894897305;2210.502636906683;2361.2562042956415;2853.9001134960176;9440.386374885611;9735.318527703064;10088.546015429323;12115.636530904087;15281.930264881463;1794.318159099534;1840.6594779965749;1849.9167537460846;1881.8118188181209;1891.0639233579466;120311;125224.99100035988;128025.35987320004;130523.0421543668;143982.99999999895;20105;20450.590988180153;20556.691649625267;21037.158513659284;21410.03654835536;34454.655453445645;34524;34543.4818477723;34625.48061779075;34698.13254668603;8568.314534837198;10379.377237365783;10653.680389588324;10683.83974240387;10823.83764243537;8714.869276960851;8776.91223087761;8830.558472076498;8941.955290223637;8987.865182022275;7810.218978102144;7868.213178682086;8626;9563.569639366246;9589.328746987643;3206.631237407728;3330.6169790474405;3810.475809676096;3831.7126215533945;3841.385378339508;377.6242638574581;380.1579501404403;693.5491930245381;862.4092496639822;870.3341943413294;11046.502907369188;11426.657200284004;11673.416329183507;11723.824142637868;12082.57710980129;423.3691799219141;424.1262998223669;424.7533489209181;433.733254048764;434.38534473719335;9761.316707830383;10866.239363244655;11149.773524912252;11952.820707689392;12467.5012999479;548093;552268;559806;563996;570516;90532;133180.3340983289;133394;134229;136800;989.8267803134422;1005.637970330695;1015.5582321689941;1023.4626820918928;1023.6110278094277;17402.73895891588;19145.52136196606;19458.416247512596;19470.221191152195;19474.513137171685;44265;44772.10455790931;56530.717346413;58769;58852.70573647104;66959;84259.5787021061;84780.72828907694;85182.57408712916;85285;6857.417119544894;7245.311695388929;7303.561786292839;7806.41451891099;8356.373272004503;12037.037037037191;12220.938895305822;12239;12643.747125057631;12811.87188128144;10539.894601053891;10572.101371383518;10672.733181670521;10963.616273430393;11239.943800280946;10779.568817247222;10944.299823142588;11004.834927476255;11018.50416731233;11327.716807079889;9334.953325233331;11067.059299959272;11169.050630696156;11249.606263780728;11377.2604780689;6596.670166491752;7616.162222155669;7807.960960195162;8088.514689118671;8216;10236.590536378462;10697.14422846186;10901.182411319342;10982.505787239754;10992.505337259683 20:36:27 INFO - PROCESS | 1647 | |3;mootools.html;1449.3767679897644;1566.342136302753;1736.7481715151296;1821.3625231169092;1906.2375049980014;8069.878951815713;8356.247937685606;8570.442921210124;9128.995810460843;9129.817403651932;8558.871616925751;8827.514486703229;8838.116188381158;8943.239824614915;8976.8653470198;2113.4610674278038;2221.866687998717;2341.262502311775;2358.3396648938237;2366.645003249509;2325.8720770357622;2350.189184731265;2350.2831636350907;2356.3637817789186;2369.57347677418;2326.7905888470036;2333.0434521846046;2344.0155134843408;2354.6703461515403;2358.186425683145;2155.7305336832897;2260.683504309398;2304.4699719064624;2310.3761984264324;2320.303908827345;2306.077568972408;2307.9884600577057;2311.711036120485;2312.849664771801;2321.5705094557393;8899.065598112169;8940.463572185625;8977.820443591158;8988.101189881025;9018.458892466408;5185.196294574347;5313.867153321159;5354.651947623392;5355.544778693816;5371.462853714636;3414.1123307939865;3473.548438702978;3610.801405922673;3619.710423166167;3625.492431059654;1043.4166630769264;1060.612876300145;1074.7152004718755;1082.2532452607675;1084.116445097251;10519.368837869752;11671.007964323127;11849.940750296193;11865.940670296593;11940.761184776256;4045.8786236412957;4554.362389265505;4794.113089078532;4836.322914791932;4852.660313778002;10053.949730251303;10120.443375614412;10128.59485620567;10141.797164056678;10155.593776248867;5295.258663786996;5362.1420572708175;5368.7047212403695;5399.541039011649;5401.1358182691365;4411.867643970686;4588.449386073693;4729.905401891943;4878.414590249193;4929.334539837076;3902.90242743928;3939.6060393960947;3969.8412063517135;4036.737612055266;4128.690348223895;1301.466398776516;1304.562971404571;1309.43039777697;1315.1057281048788;1316.2694704439127;820.9179082091744;912.3522299167532;915.4232833314969;922.1424075609748;956.4691596164196;5759.395263497357;5863.941360586425;5926.970365148147;6022.57841951068;6154.046122850965;363.58914426697663;890.8797312362877;993.5082134343546;1007.5163921317809;1057.830747080479;3943.2310699413338;3997.080671445584;4072.511298644182;4100.138970816162;4113.588641135862;10512.947435262928;10776.67669969902;10811.945940270249;10876.021158095651;10909.127269818395;10779.730506737238;10794.082502987334;10801.189910756568;10838.458077096113;10860.511276992554;7707.075150981918;7951.522908625501;8176.264136227768;8224.177582241728;8260.586970651324;5848.5028772553105;5852.970735146297;5873.471387575139;5987.371326010881;6043.395660433922;7859.292663660298;9689.612415503301;9699.563519641491;9769.560369783234;9784.755381115529;9575.04249575037;9728.429523823519;9867.06262905023;9871.654492092743;9877.012298770065;7029.29707029293;7204;7253.202147763847;7528.473006889684;7675.808104797201;8066.435349525712;8233.217844304781;8356.623951922056;8370.665173392996;8383.329333653415;7181.784546463615;7401.296876796696;7405.925940740739;7461.440391970733;7594.544327340377;7241.818954526179;7300.050993370828;7404.925950740424;7490.4007679386605;7491.925080749123;7014.894776578253;7066.328698773608;7133.8929916050265;7140.7857764267155;7162.319579639926;4907.386576677915;4973.577245934136;5012.147934851011;5079.492050794891;5101.846944591668;4841.2496063110275;4845.781939812647;4970.577500912463;4999.250112483157;5109.565686916654 20:36:27 INFO - PROCESS | 1647 | |4;prototype.html;284.84048932597744;290.2004976290319;296.962879640045;307.86761692472237;313.68161316263996;4886.755662216893;5410.404855465896;5513.586481013925;5529.751161197751;5586.497215250627;4980.252962055693;5185.833187532803;5301.549368303689;5317.707526086064;5498;4225.197212529617;4257.318828987362;4293.09844932563;4297.785110744466;4306.956930430702;3767.660910518053;4218.3250679891225;4280.550542193072;4284.271673815459;4346.978460061899;4187.476565429321;4194.266003449399;4204;4221.620054195122;4279.764612946286;4255.319148936171;4257.59552842481;4271.953371424021;4273.871783846458;4292.484901811803;3574.8439826088497;3700.5374328208973;3705.4071348584366;3716.609755975611;3738.3831667774784;4100.897477563055;4792.760361981887;5461.399246082928;5479.1781232815;5504.256925315071;4909.7790599423115;4917.680350777188;4924.015196960587;4928.359313289249;4934.555889969884;4678.789454474523;5588.826346467246;5832;5922.674252916088;5923.911141332884;3703.1112532992156;3927.725059245854;3935.704822138351;3937.2125574885135;3945.3687410014545;4980.936723914766;5345.679259244458;5858.326292476335;6214.720337584819;6220.47125994291;3985.940210896839;3990.20195960809;3996.5803590623145;4006.4759201703323;4009.7393669411395;3615.9276814463565;3719.8512059517857;3979;4059.512858456945;4069.1861627674584;4312.568743125662;4528.46406012634;4751.434225518251;4776.376032149086;4783.278019912828;4776.47458779534;4975.601951843843;5967.343592204854;5969.970150149222;5990;1226.5523084074248;1291.141390974991;1334.5329134802935;1362.9591112266648;1373.7183877305129;834.5910503853069;899.9820003599891;911.2755359489222;922.8154369126202;924.4360939826701;5634.267545219177;5641.843422098542;5645.096784514458;5646.85882852932;5703.62926409782;4941.827036053721;5410.322799932033;5733.3406658234835;5912.906112369139;6204.875902482016;4634.331640609378;4776.307435421914;4793.424789025269;5469.206964990134;5680.346760122557;2484.850908945469;2559.7184309725917;2682.015308671569;2758.6413766210667;2768.1972228053637;4482.9775851121185;4896.037897072291;5307.389650190277;5349.625526213205;5357.624966252325;4569.9314510282375;5094.777253459143;5755.913661295084;6339.936600634027;6393.6163830170335;6459.450946669585;6489.902651460232;6501.024846273097;6549.541532092708;6552.246491653425;5418.234327142755;5880.647161170173;5950.702464876826;6223.693024464913;6244.250689917239;5099.6175286852895;6068.605540639845;6069.089636554552;6076.939230607637;6149.907751383644;6408.487321014214;6409;6415.369698423624;6437.935620643733;6514.283428822731;3503.719702423851;3699.225580814389;3722.739408241397;3931.410288456754;3999.3001224786126;5102.974485127551;6157.384261573807;6175.289841668266;6178.289496707756;6183.84540386494;5813.970930145322;5897.115432685132;5968.8806223876145;5981.940180598138;5984.760609575568;5009.348784657971;5933.881322373442;5953.196318497121;5979.641221526722;5988.341282458839;4840.709557426425;5052.9388828346455;5759.96320662268;5807.651540907559;5864.472197502245;4950.801967921243;5640.32316122068;5781.682007489629;5913.379095194942;6028.3971602839365;5133.486651334837;5179.48205179479;5438.129899216106;5717.256756621613;5868.618539794899 20:36:27 INFO - PROCESS | 1647 | |5;yui.html;716.251517164563;750.2197714377048;759.4418102694518;762.6377470701417;802.9076656184538;15140.394384224632;16202.918985405086;16372.754408683879;16375.754363684555;16449.424270150546;14848.331825067871;15434.768478472832;15897.205139743024;16048.59878503038;16534.83465165348;874.5277550122942;899.5502248875562;899.7480705402497;901.4185850126664;901.4726385064712;713.6039498078565;738.3723834740481;871.6949067826273;896.5158814240302;900.4822227219342;947.1948843483019;965.657191696948;967.6274634265823;969.0261287406147;969.3505351414569;963.2679163835465;964.4309857184295;964.9565769540352;965.165132160683;967.3808762392075;705.0552259971612;714.3535100733844;715.7781087862727;717.2827172827173;721.7077083781077;15589.610259743484;15728.213589320489;15956.441524546584;16037.198140093065;16081.437149699705;11347.375894325809;13836.377363018688;14254.857451425456;14492.565223043326;14498.71002579953;11823.290602563873;11953.760924781544;12053.63839084829;12129.272243665408;12306.630801075982;3581.910452238689;3719.609441008682;3745.4970062855527;3763.435484677293;3905.9218815623813;119052.40473797663;119579.4021029898;119751;121094;121783.3910830449;10614.203934704774;10662.573497060032;10743.946280268548;10786.406747628957;10823.404712740718;16418.589535261715;19936;20959.68560471594;21176.78823211779;21181.576368472543;7839;7965.8805117923275;8028.518288902685;8048.718294859652;8117.594120293962;4383.7808109595035;4544.136614043321;4592.334111553806;4615.930761038587;4619.792109355087;3633.3823250047553;3697.0942119180972;3744.475773391727;3747.1568896997956;3750.1562148516364;658.8451713847242;670.9834600580125;716.7419728897593;720.5784615999594;757.9469437139458;558.5196730811499;589.9882002360015;609.4636719686647;650.3009265040006;700.1003710232327;8582.485050896967;9225.12361325673;9489.66786162481;9670.903290967;9971.551280192409;586.519054375408;609.960352577081;636.5830381100386;679.5175425447987;681.6114814555656;4399.956000440018;4668.11305851887;4690.390249267573;4739.881502962385;4773.9761301193275;100627;138477;161144;163390.3660963375;166028;135716;137219;142939;143905;143909.8413523798;75096;92920.07079929115;96235;104321.47839260907;110930.44534777275;9406.858897116686;9926.354786938826;9927.305088644014;9970.155521228597;9977.151942084714;63783.362166377745;63803.36196637974;65504.672476637315;65875.67062164658;67185.25813757075;92459.07540924505;95081;96253;100077;100122.4993875026;12451.128421010442;12815.359232038547;13090.934545327593;13139.54011609589;13311.068225224142;11794;12548.749025019266;14569.198694071927;14799.92600036993;15308.617284567976;13429.992750543553;13566.118202316818;13653.795193071914;14320.928395358373;14331.996760226684;13419.731605368033;13553.525626603416;13671.726565468436;13673.521426750414;14102.36539355711;11412.771744565229;13706.93146534261;13966.650833729238;13993.440262389391;14129.293535323399;11256.662300131009;11435.085193184359;11437.142214334124;11458.484368203617;11576;7194.460415468965;10166.390016599027;10763.51564179598;11293.943530282297;11645.59240426581 20:36:27 INFO - PROCESS | 1647 | __end_tp_report 20:36:27 INFO - PROCESS | 1647 | __start_cc_report 20:36:27 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,366 20:36:27 INFO - PROCESS | 1647 | __end_cc_report 20:36:27 INFO - PROCESS | 1647 | __startTimestamp1477280187215__endTimestamp 20:36:27 INFO - PROCESS | 1647 | 20:36:27 INFO - PROCESS | 1647 | ------- Summary: start ------- 20:36:27 INFO - PROCESS | 1647 | Number of tests: 6 20:36:27 INFO - PROCESS | 1647 | 20:36:27 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5717.03 Median:5986.85 stddev:664.61 (11.1%) stddev-sans-first:641.65 20:36:27 INFO - PROCESS | 1647 | Values: 3415.5 3427.3 3451.7 3453.0 3478.9 5619.9 5761.8 5799.4 5817.7 5842.4 5476.4 5651.3 5739.9 5795.0 5836.1 5152.5 5236.5 5237.9 5248.7 5315.1 4661.7 5130.4 5197.6 5319.1 5412.9 4218.7 5245.0 5253.8 5290.2 5298.5 5106.5 5174.8 5177.8 5206.0 5271.1 5147.8 5149.2 5179.1 5184.5 5189.6 4356.7 4503.0 5417.5 5743.7 5766.5 5173.9 6078.6 6098.6 6158.0 6277.1 6303.7 6303.8 6309.8 6312.2 6329.9 5886.6 5900.7 5904.8 5986.9 6013.1 6111.2 6127.1 6163.9 6197.6 6340.4 6111.1 6128.9 6171.8 6181.2 6194.0 6089.5 6181.4 6196.5 6202.7 6212.6 6086.8 6110.3 6158.3 6167.5 6281.9 6248.2 6289.9 6296.2 6299.0 6315.9 4885.6 4943.1 4944.4 4948.2 4975.0 4342.6 4415.8 4422.8 4428.8 4455.3 5349.7 5441.5 5794.1 5885.0 5921.3 5188.0 6240.2 6287.3 6319.5 6320.0 5632.8 5756.9 5825.6 5850.7 5872.2 5346.6 5375.4 5390.0 5418.7 5458.0 6309.0 6316.2 6318.2 6321.8 6330.0 6130.4 6291.3 6313.2 6319.2 6327.8 6225.3 6236.0 6244.9 6283.3 6292.9 6242.5 6260.5 6263.8 6267.8 6268.0 5965.6 6099.0 6286.8 6307.1 6325.6 5759.3 6075.2 6109.5 6121.3 6178.4 6087.7 6129.1 6139.9 6152.3 6177.1 5815.0 5871.7 5916.2 6001.6 6036.2 6064.7 6115.8 6116.6 6117.3 6142.6 4967.7 5977.7 5989.3 5993.5 6013.2 20:36:27 INFO - PROCESS | 1647 | 20:36:27 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:68714.47 Median:40615.00 stddev:148311.56 (365.2%) stddev-sans-first:148639.06 20:36:27 INFO - PROCESS | 1647 | Values: 452.6 473.0 524.3 546.1 562.9 33535.0 38380.8 40474.8 40567.0 40663.0 41175.4 41384.4 41670.8 41775.2 41865.0 9322.3 9365.6 9466.8 9521.8 9557.0 9440.9 9507.8 9518.9 9531.7 9545.4 9516.9 9523.6 9569.3 9580.6 9589.6 9500.0 9502.8 9518.2 9521.1 9545.7 9268.8 9346.0 9350.1 9377.1 9389.5 39201.8 39301.4 39302.0 39318.2 39395.8 3022.5 3277.7 3462.5 3562.3 3632.8 30017.8 31400.8 31796.0 31803.9 31842.4 3187.0 3193.7 3246.0 3335.5 3383.2 454506.7 455012.0 458520.0 461333.0 464278.0 62501.4 62913.7 63034.0 63107.0 63182.0 65581.7 65703.0 65929.0 66047.3 66262.0 16006.6 16173.4 16203.5 16212.3 16218.8 12389.3 12420.5 12470.6 12523.4 12575.7 18461.5 19273.5 19320.9 19347.9 19404.7 7953.6 8100.9 8106.7 8139.9 8187.6 824.6 959.2 964.5 990.9 1051.5 29578.7 29837.9 30079.8 30697.8 30994.7 909.5 1013.7 1035.5 1078.3 1114.3 14854.3 15273.5 15685.8 15882.7 15932.0 616088.0 650899.0 655699.0 656217.7 656647.0 57262.0 57578.0 57867.7 57922.7 58012.7 1073.9 1160.5 1347.1 1369.6 1402.0 25979.4 29010.3 29789.7 29844.4 30372.8 50346.0 50427.7 50935.2 50972.2 51080.7 475951.0 554638.0 558929.0 561662.0 561735.0 26481.2 26817.7 26853.9 26877.7 26882.1 46290.5 46778.0 46907.5 47976.0 48016.3 32611.8 39319.8 41136.0 41526.4 42120.0 32949.5 38340.0 38633.8 39333.8 39508.2 32499.0 37961.4 38016.9 38340.8 40524.8 32048.8 34645.1 35039.8 35383.6 35431.0 25154.6 25289.6 25384.4 25764.5 25768.1 20:36:27 INFO - PROCESS | 1647 | 20:36:27 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:34665.70 Median:18892.64 stddev:93981.61 (497.5%) stddev-sans-first:94209.81 20:36:27 INFO - PROCESS | 1647 | Values: 288.5 369.4 372.7 384.5 403.0 19171.8 19652.6 20447.0 20799.0 21069.5 19436.7 19787.5 20761.8 20940.7 20947.5 5822.9 5875.8 6019.3 6034.4 6083.2 5908.8 5937.6 6003.6 6031.0 6046.4 5634.0 5886.2 5926.9 5973.6 5994.3 5897.5 5954.4 6006.3 6008.7 6021.1 5108.5 5186.3 5352.4 5428.8 5480.7 12482.5 12697.4 12705.5 12922.0 12922.3 2049.4 2062.3 2210.5 2361.3 2853.9 9440.4 9735.3 10088.5 12115.6 15281.9 1794.3 1840.7 1849.9 1881.8 1891.1 120311.0 125225.0 128025.4 130523.0 143983.0 20105.0 20450.6 20556.7 21037.2 21410.0 34454.7 34524.0 34543.5 34625.5 34698.1 8568.3 10379.4 10653.7 10683.8 10823.8 8714.9 8776.9 8830.6 8942.0 8987.9 7810.2 7868.2 8626.0 9563.6 9589.3 3206.6 3330.6 3810.5 3831.7 3841.4 377.6 380.2 693.5 862.4 870.3 11046.5 11426.7 11673.4 11723.8 12082.6 423.4 424.1 424.8 433.7 434.4 9761.3 10866.2 11149.8 11952.8 12467.5 548093.0 552268.0 559806.0 563996.0 570516.0 90532.0 133180.3 133394.0 134229.0 136800.0 989.8 1005.6 1015.6 1023.5 1023.6 17402.7 19145.5 19458.4 19470.2 19474.5 44265.0 44772.1 56530.7 58769.0 58852.7 66959.0 84259.6 84780.7 85182.6 85285.0 6857.4 7245.3 7303.6 7806.4 8356.4 12037.0 12220.9 12239.0 12643.7 12811.9 10539.9 10572.1 10672.7 10963.6 11239.9 10779.6 10944.3 11004.8 11018.5 11327.7 9335.0 11067.1 11169.1 11249.6 11377.3 6596.7 7616.2 7808.0 8088.5 8216.0 10236.6 10697.1 10901.2 10982.5 10992.5 20:36:27 INFO - PROCESS | 1647 | 20:36:27 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5702.29 Median:4949.96 stddev:3187.59 (64.4%) stddev-sans-first:3180.51 20:36:27 INFO - PROCESS | 1647 | Values: 1449.4 1566.3 1736.7 1821.4 1906.2 8069.9 8356.2 8570.4 9129.0 9129.8 8558.9 8827.5 8838.1 8943.2 8976.9 2113.5 2221.9 2341.3 2358.3 2366.6 2325.9 2350.2 2350.3 2356.4 2369.6 2326.8 2333.0 2344.0 2354.7 2358.2 2155.7 2260.7 2304.5 2310.4 2320.3 2306.1 2308.0 2311.7 2312.8 2321.6 8899.1 8940.5 8977.8 8988.1 9018.5 5185.2 5313.9 5354.7 5355.5 5371.5 3414.1 3473.5 3610.8 3619.7 3625.5 1043.4 1060.6 1074.7 1082.3 1084.1 10519.4 11671.0 11849.9 11865.9 11940.8 4045.9 4554.4 4794.1 4836.3 4852.7 10053.9 10120.4 10128.6 10141.8 10155.6 5295.3 5362.1 5368.7 5399.5 5401.1 4411.9 4588.4 4729.9 4878.4 4929.3 3902.9 3939.6 3969.8 4036.7 4128.7 1301.5 1304.6 1309.4 1315.1 1316.3 820.9 912.4 915.4 922.1 956.5 5759.4 5863.9 5927.0 6022.6 6154.0 363.6 890.9 993.5 1007.5 1057.8 3943.2 3997.1 4072.5 4100.1 4113.6 10512.9 10776.7 10811.9 10876.0 10909.1 10779.7 10794.1 10801.2 10838.5 10860.5 7707.1 7951.5 8176.3 8224.2 8260.6 5848.5 5853.0 5873.5 5987.4 6043.4 7859.3 9689.6 9699.6 9769.6 9784.8 9575.0 9728.4 9867.1 9871.7 9877.0 7029.3 7204.0 7253.2 7528.5 7675.8 8066.4 8233.2 8356.6 8370.7 8383.3 7181.8 7401.3 7405.9 7461.4 7594.5 7241.8 7300.1 7404.9 7490.4 7491.9 7014.9 7066.3 7133.9 7140.8 7162.3 4907.4 4973.6 5012.1 5079.5 5101.8 4841.2 4845.8 4970.6 4999.3 5109.6 20:36:27 INFO - PROCESS | 1647 | 20:36:27 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4710.34 Median:5101.30 stddev:1489.27 (29.2%) stddev-sans-first:1455.93 20:36:27 INFO - PROCESS | 1647 | Values: 284.8 290.2 297.0 307.9 313.7 4886.8 5410.4 5513.6 5529.8 5586.5 4980.3 5185.8 5301.5 5317.7 5498.0 4225.2 4257.3 4293.1 4297.8 4307.0 3767.7 4218.3 4280.6 4284.3 4347.0 4187.5 4194.3 4204.0 4221.6 4279.8 4255.3 4257.6 4272.0 4273.9 4292.5 3574.8 3700.5 3705.4 3716.6 3738.4 4100.9 4792.8 5461.4 5479.2 5504.3 4909.8 4917.7 4924.0 4928.4 4934.6 4678.8 5588.8 5832.0 5922.7 5923.9 3703.1 3927.7 3935.7 3937.2 3945.4 4980.9 5345.7 5858.3 6214.7 6220.5 3985.9 3990.2 3996.6 4006.5 4009.7 3615.9 3719.9 3979.0 4059.5 4069.2 4312.6 4528.5 4751.4 4776.4 4783.3 4776.5 4975.6 5967.3 5970.0 5990.0 1226.6 1291.1 1334.5 1363.0 1373.7 834.6 900.0 911.3 922.8 924.4 5634.3 5641.8 5645.1 5646.9 5703.6 4941.8 5410.3 5733.3 5912.9 6204.9 4634.3 4776.3 4793.4 5469.2 5680.3 2484.9 2559.7 2682.0 2758.6 2768.2 4483.0 4896.0 5307.4 5349.6 5357.6 4569.9 5094.8 5755.9 6339.9 6393.6 6459.5 6489.9 6501.0 6549.5 6552.2 5418.2 5880.6 5950.7 6223.7 6244.3 5099.6 6068.6 6069.1 6076.9 6149.9 6408.5 6409.0 6415.4 6437.9 6514.3 3503.7 3699.2 3722.7 3931.4 3999.3 5103.0 6157.4 6175.3 6178.3 6183.8 5814.0 5897.1 5968.9 5981.9 5984.8 5009.3 5933.9 5953.2 5979.6 5988.3 4840.7 5052.9 5760.0 5807.7 5864.5 4950.8 5640.3 5781.7 5913.4 6028.4 5133.5 5179.5 5438.1 5717.3 5868.6 20:36:27 INFO - PROCESS | 1647 | 20:36:27 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:25260.27 Median:3708.35 stddev:40696.21 (1097.4%) stddev-sans-first:40768.64 20:36:27 INFO - PROCESS | 1647 | Values: 716.3 750.2 759.4 762.6 802.9 15140.4 16202.9 16372.8 16375.8 16449.4 14848.3 15434.8 15897.2 16048.6 16534.8 874.5 899.6 899.7 901.4 901.5 713.6 738.4 871.7 896.5 900.5 947.2 965.7 967.6 969.0 969.4 963.3 964.4 965.0 965.2 967.4 705.1 714.4 715.8 717.3 721.7 15589.6 15728.2 15956.4 16037.2 16081.4 11347.4 13836.4 14254.9 14492.6 14498.7 11823.3 11953.8 12053.6 12129.3 12306.6 3581.9 3719.6 3745.5 3763.4 3905.9 119052.4 119579.4 119751.0 121094.0 121783.4 10614.2 10662.6 10743.9 10786.4 10823.4 16418.6 19936.0 20959.7 21176.8 21181.6 7839.0 7965.9 8028.5 8048.7 8117.6 4383.8 4544.1 4592.3 4615.9 4619.8 3633.4 3697.1 3744.5 3747.2 3750.2 658.8 671.0 716.7 720.6 757.9 558.5 590.0 609.5 650.3 700.1 8582.5 9225.1 9489.7 9670.9 9971.6 586.5 610.0 636.6 679.5 681.6 4400.0 4668.1 4690.4 4739.9 4774.0 100627.0 138477.0 161144.0 163390.4 166028.0 135716.0 137219.0 142939.0 143905.0 143909.8 75096.0 92920.1 96235.0 104321.5 110930.4 9406.9 9926.4 9927.3 9970.2 9977.2 63783.4 63803.4 65504.7 65875.7 67185.3 92459.1 95081.0 96253.0 100077.0 100122.5 12451.1 12815.4 13090.9 13139.5 13311.1 11794.0 12548.7 14569.2 14799.9 15308.6 13430.0 13566.1 13653.8 14320.9 14332.0 13419.7 13553.5 13671.7 13673.5 14102.4 11412.8 13706.9 13966.7 13993.4 14129.3 11256.7 11435.1 11437.1 11458.5 11576.0 7194.5 10166.4 10763.5 11293.9 11645.6 20:36:27 INFO - PROCESS | 1647 | -------- Summary: end -------- 20:36:27 INFO - PROCESS | 1647 | 20:36:27 INFO - TEST-INFO | 1647: exit 0 20:36:27 INFO - TEST-OK | dromaeo_css | took 1115338ms 20:36:27 INFO - TEST-START | kraken 20:36:27 INFO - operating with platform_type : mac_ 20:36:27 INFO - Initialising browser for kraken test... 20:36:27 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpa46wfh/profile http://localhost:49272/getInfo.html) 20:36:30 INFO - PROCESS | 1659 | 2016-10-23 20:36:30.714 plugin-container[1660:9834] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 20:36:30 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:36:30 INFO - PROCESS | 1659 | 2016-10-23 20:36:30.717 plugin-container[1660:9834] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 20:36:30 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:36:30 INFO - PROCESS | 1659 | 2016-10-23 20:36:30.717 plugin-container[1660:9834] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:36:30 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 20:36:30 INFO - PROCESS | 1659 | colorDepth:24 20:36:30 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 20:36:30 INFO - PROCESS | 1659 | __metrics 20:36:30 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 20:36:31 INFO - TEST-INFO | 1659: exit 0 20:36:31 INFO - Browser initialized. 20:36:31 INFO - Running cycle 1/1 for kraken test... 20:36:31 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpa46wfh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:36:33 INFO - PROCESS | 1661 | 2016-10-23 20:36:33.911 plugin-container[1662:9947] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 20:36:33 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:36:33 INFO - PROCESS | 1661 | 2016-10-23 20:36:33.912 plugin-container[1662:9947] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 20:36:33 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:36:33 INFO - PROCESS | 1661 | 2016-10-23 20:36:33.912 plugin-container[1662:9947] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:36:43 INFO - PROCESS | 1661 | RSS: Main: 236720128 20:36:43 INFO - PROCESS | 1661 | 20:36:46 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 20:36:47 INFO - PROCESS | 1661 | RSS: Main: 249053184 20:36:47 INFO - PROCESS | 1661 | 20:36:50 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 20:36:50 INFO - PROCESS | 1661 | RSS: Main: 257736704 20:36:50 INFO - PROCESS | 1661 | 20:36:54 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 20:36:54 INFO - PROCESS | 1661 | RSS: Main: 259870720 20:36:54 INFO - PROCESS | 1661 | 20:36:56 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 20:36:57 INFO - PROCESS | 1661 | RSS: Main: 262070272 20:36:57 INFO - PROCESS | 1661 | 20:36:59 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:37:00 INFO - PROCESS | 1661 | RSS: Main: 262426624 20:37:00 INFO - PROCESS | 1661 | 20:37:02 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 20:37:03 INFO - PROCESS | 1661 | RSS: Main: 263159808 20:37:03 INFO - PROCESS | 1661 | 20:37:06 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 20:37:07 INFO - PROCESS | 1661 | RSS: Main: 263303168 20:37:07 INFO - PROCESS | 1661 | 20:37:10 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 20:37:10 INFO - PROCESS | 1661 | RSS: Main: 263573504 20:37:10 INFO - PROCESS | 1661 | 20:37:12 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:37:13 INFO - PROCESS | 1661 | RSS: Main: 263225344 20:37:13 INFO - PROCESS | 1661 | 20:37:15 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:37:15 INFO - PROCESS | 1661 | RSS: Main: 263335936 20:37:15 INFO - PROCESS | 1661 | 20:37:18 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:37:18 INFO - PROCESS | 1661 | RSS: Main: 263413760 20:37:18 INFO - PROCESS | 1661 | 20:37:21 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:37:22 INFO - PROCESS | 1661 | RSS: Main: 263860224 20:37:22 INFO - PROCESS | 1661 | 20:37:25 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:37:26 INFO - PROCESS | 1661 | RSS: Main: 263602176 20:37:26 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 20:37:28 INFO - PROCESS | 1661 | RSS: Main: 265220096 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | __start_tp_report 20:37:28 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 20:37:28 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 20:37:28 INFO - PROCESS | 1661 | |i|pagename|runs| 20:37:28 INFO - PROCESS | 1661 | |0;ai-astar;107;118;118;118;115;118;118;117;117;120 20:37:28 INFO - PROCESS | 1661 | |1;audio-beat-detection;152;121;145;154;145;108;145;152;177;114 20:37:28 INFO - PROCESS | 1661 | |2;audio-dft;196;206;224;202;195;197;198;198;233;211 20:37:28 INFO - PROCESS | 1661 | |3;audio-fft;77;59;58;86;58;58;58;59;93;84 20:37:28 INFO - PROCESS | 1661 | |4;audio-oscillator;86;69;84;58;65;76;125;99;102;73 20:37:28 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;90;88;97;120;90;87;91;76;120;129 20:37:28 INFO - PROCESS | 1661 | |6;imaging-darkroom;99;100;99;100;98;99;99;133;172;100 20:37:28 INFO - PROCESS | 1661 | |7;imaging-desaturate;70;136;114;139;130;89;138;103;110;89 20:37:28 INFO - PROCESS | 1661 | |8;json-parse-financial;55;58;61;79;89;90;50;50;81;78 20:37:28 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;67;69;79;79;76;68;70;70;70;76 20:37:28 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;88;86;99;106;109;111;103;91;104;90 20:37:28 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;158;140;156;165;163;150;179;160;208;158 20:37:28 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;188;175;171;175;173;173;192;176;232;185 20:37:28 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;60;82;89;73;63;63;87;64;71;77 20:37:28 INFO - PROCESS | 1661 | __end_tp_report 20:37:28 INFO - PROCESS | 1661 | __start_cc_report 20:37:28 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,936 20:37:28 INFO - PROCESS | 1661 | __end_cc_report 20:37:28 INFO - PROCESS | 1661 | __startTimestamp1477280248369__endTimestamp 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | ------- Summary: start ------- 20:37:28 INFO - PROCESS | 1661 | Number of tests: 14 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:116.60 Median:118.00 stddev:3.60 (3.0%) stddev-sans-first:1.32 20:37:28 INFO - PROCESS | 1661 | Values: 107.0 118.0 118.0 118.0 115.0 118.0 118.0 117.0 117.0 120.0 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:148.50 stddev:21.01 (14.1%) stddev-sans-first:21.92 20:37:28 INFO - PROCESS | 1661 | Values: 152.0 121.0 145.0 154.0 145.0 108.0 145.0 152.0 177.0 114.0 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:206.00 Median:204.00 stddev:13.01 (6.4%) stddev-sans-first:13.29 20:37:28 INFO - PROCESS | 1661 | Values: 196.0 206.0 224.0 202.0 195.0 197.0 198.0 198.0 233.0 211.0 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:69.00 Median:68.00 stddev:14.29 (21.0%) stddev-sans-first:14.86 20:37:28 INFO - PROCESS | 1661 | Values: 77.0 59.0 58.0 86.0 58.0 58.0 58.0 59.0 93.0 84.0 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:83.70 Median:74.50 stddev:20.22 (27.1%) stddev-sans-first:21.43 20:37:28 INFO - PROCESS | 1661 | Values: 86.0 69.0 84.0 58.0 65.0 76.0 125.0 99.0 102.0 73.0 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:98.80 Median:89.00 stddev:17.66 (19.8%) stddev-sans-first:18.44 20:37:28 INFO - PROCESS | 1661 | Values: 90.0 88.0 97.0 120.0 90.0 87.0 91.0 76.0 120.0 129.0 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:109.90 Median:98.50 stddev:24.27 (24.6%) stddev-sans-first:25.42 20:37:28 INFO - PROCESS | 1661 | Values: 99.0 100.0 99.0 100.0 98.0 99.0 99.0 133.0 172.0 100.0 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:111.80 Median:138.50 stddev:24.07 (17.4%) stddev-sans-first:20.23 20:37:28 INFO - PROCESS | 1661 | Values: 70.0 136.0 114.0 139.0 130.0 89.0 138.0 103.0 110.0 89.0 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:78.50 stddev:15.88 (20.2%) stddev-sans-first:16.00 20:37:28 INFO - PROCESS | 1661 | Values: 55.0 58.0 61.0 79.0 89.0 90.0 50.0 50.0 81.0 78.0 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:73.00 stddev:4.60 (6.3%) stddev-sans-first:4.44 20:37:28 INFO - PROCESS | 1661 | Values: 67.0 69.0 79.0 79.0 76.0 68.0 70.0 70.0 70.0 76.0 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:98.70 Median:87.00 stddev:9.24 (10.6%) stddev-sans-first:8.95 20:37:28 INFO - PROCESS | 1661 | Values: 88.0 86.0 99.0 106.0 109.0 111.0 103.0 91.0 104.0 90.0 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:163.70 Median:161.50 stddev:18.52 (11.5%) stddev-sans-first:19.53 20:37:28 INFO - PROCESS | 1661 | Values: 158.0 140.0 156.0 165.0 163.0 150.0 179.0 160.0 208.0 158.0 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.00 Median:180.50 stddev:18.32 (10.2%) stddev-sans-first:19.38 20:37:28 INFO - PROCESS | 1661 | Values: 188.0 175.0 171.0 175.0 173.0 173.0 192.0 176.0 232.0 185.0 20:37:28 INFO - PROCESS | 1661 | 20:37:28 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:75.00 stddev:10.56 (14.1%) stddev-sans-first:10.11 20:37:28 INFO - PROCESS | 1661 | Values: 60.0 82.0 89.0 73.0 63.0 63.0 87.0 64.0 71.0 77.0 20:37:28 INFO - PROCESS | 1661 | -------- Summary: end -------- 20:37:28 INFO - PROCESS | 1661 | 20:37:29 INFO - TEST-INFO | 1661: exit 0 20:37:29 INFO - TEST-OK | kraken | took 61308ms 20:37:29 INFO - SUITE-END | took 1176s 20:37:29 INFO - Completed test suite (00:19:36) 20:37:29 INFO - javascript benchmark 20:37:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7432.223180922991, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3415.4876768484723, 3427.2631384252395, 3451.654834516547, 3452.999999999999, 3478.8608455661774, 5619.943800561993, 5761.798337058204, 5799.420057994198, 5817.650940943547, 5842.386549412309, 5476.397596264408, 5651.2935883014625, 5739.942600573993, 5795.043817770063, 5836.095405212188, 5152.510511501401, 5236.450172731866, 5237.921431178535, 5248.658837175591, 5315.096433606296, 4661.65037622178, 5130.410002849664, 5197.558207552363, 5319.148936170213, 5412.9458705413035, 4218.725782824106, 5244.973775131119, 5253.842384728464, 5290.206469029637, 5298.470152984709, 5106.463821298785, 5174.793008279665, 5177.8187763428095, 5206.036883176586, 5271.077561426735, 5147.7683504242395, 5149.176131818891, 5179.067767801795, 5184.533391994739, 5189.584833213334, 4356.695031347807, 4503.03184815263, 5417.51242388183, 5743.655380677173, 5766.509846662997, 5173.896522069575, 6078.574499785017, 6098.60359076663, 6158.0, 6277.121203031534, 6303.653299068549, 6303.779367722108, 6309.810705678837, 6312.179416675849, 6329.905051424233, 5886.646801191942, 5900.675462849542, 5904.822855314347, 5986.850328741816, 6013.128096425994, 6111.166351794787, 6127.111568822495, 6163.907541386883, 6197.597156184834, 6340.365963403715, 6111.052786818051, 6128.900367973304, 6171.783987560414, 6181.196444462191, 6194.0, 6089.512838972872, 6181.443670069715, 6196.47329976948, 6202.72087756052, 6212.627242365473, 6086.756529738849, 6110.346130329488, 6158.322584515699, 6167.537434692326, 6281.874362512815, 6248.218972628421, 6289.8742025159245, 6296.244450665949, 6299.0, 6315.873682526324, 4885.560299572984, 4943.060818444484, 4944.357233559686, 4948.158813001726, 4975.0, 4342.609165175149, 4415.779211039435, 4422.75674837887, 4428.778561071934, 4455.309427038814, 5349.689326115126, 5441.455854414606, 5794.072948328248, 5885.028970219952, 5921.259842519685, 5187.974060129675, 6240.157578726905, 6287.308396076428, 6319.46284565817, 6320.0, 5632.831015069554, 5756.942430575725, 5825.592208545446, 5850.736716847752, 5872.17789509469, 5346.625736198429, 5375.408705042442, 5389.973050134724, 5418.674879507243, 5457.972710136503, 6309.022101574264, 6316.178896743486, 6318.210223721942, 6321.810345689637, 6330.0, 6130.417610327012, 6291.285632104097, 6313.210848643919, 6319.210098737658, 6327.810165695037, 6225.315215326401, 6236.03341482071, 6244.906326405198, 6283.2774230962195, 6292.937070629235, 6242.531810114168, 6260.530460215411, 6263.843403914939, 6267.780627678009, 6268.028455589391, 5965.582409231312, 6099.0, 6286.842828929313, 6307.117003619405, 6325.588836725598, 5759.308882934075, 6075.2405949256345, 6109.526129009804, 6121.326654068138, 6178.351273116258, 6087.659905928906, 6129.08063790435, 6139.938600613937, 6152.292486364126, 6177.104319873683, 5814.970925145347, 5871.6770577618645, 5916.230889984275, 6001.5798894077, 6036.215292012011, 6064.666443345658, 6115.816525504242, 6116.602420842631, 6117.3402608778015, 6142.590862071594, 4967.726775027264, 5977.701114944322, 5989.311229208697, 5993.520518358434, 6013.158157857816], "value": 5676.213575803274, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [452.57005844447775, 472.9760069449642, 524.2869697211794, 546.0934848152067, 562.8536580489072, 33535.0, 38380.848574542775, 40474.79762601187, 40566.99999999993, 40663.0, 41175.38236926441, 41384.37923431143, 41670.791646041806, 41775.16449671005, 41864.95337616561, 9322.347435679489, 9365.625374984993, 9466.81066378672, 9521.761955951122, 9556.99651536589, 9440.905590944072, 9507.762305942337, 9518.857217141749, 9531.666391676292, 9545.379550329206, 9516.857247141299, 9523.619055237818, 9569.282303827205, 9580.61677532898, 9589.616415343378, 9500.049995000514, 9502.762430939212, 9518.238540916711, 9521.143097121223, 9545.713628591153, 9268.814623707556, 9346.0, 9350.064993500664, 9377.1091746284, 9389.483578403186, 39201.803990980145, 39301.41047884284, 39302.017449563704, 39318.213635727414, 39395.803020985, 3022.4710675631895, 3277.705006549422, 3462.5325581046486, 3562.305350456662, 3632.8365223565, 30017.849910750305, 31400.787543225102, 31796.0, 31803.88686395988, 31842.363152736816, 3186.952195717066, 3193.680631936788, 3245.983770081158, 3335.4663253879507, 3383.2218589724257, 454506.72746636387, 455012.0, 458520.0, 461333.0, 464278.0, 62501.37498624955, 62913.68543157347, 63034.0, 63107.0, 63182.0, 65581.67209163924, 65703.0, 65929.0, 66047.33952660508, 66262.0, 16006.599835003984, 16173.353065877232, 16203.513894583182, 16212.270447829877, 16218.837811621968, 12389.256644601353, 12420.503179872703, 12470.563530276397, 12523.436445359981, 12575.679553646918, 18461.461860187268, 19273.51816204606, 19320.903395482932, 19347.903260483607, 19404.708929366072, 7953.602319883983, 8100.878486822702, 8106.675732970615, 8139.877901831477, 8187.590620468953, 824.6371596497522, 959.2326139088701, 964.4888209249109, 990.8563258327503, 1051.5320682296458, 29578.704212957597, 29837.850810745807, 30079.849600751855, 30697.84651076775, 30994.69005309963, 909.486140330711, 1013.7060252526832, 1035.4615599888016, 1078.2937176149635, 1114.2979922648842, 14854.331555080047, 15273.465428709942, 15685.843141568666, 15882.682346353009, 15932.0, 616088.0, 650899.0, 655699.0, 656217.7189114024, 656647.0, 57262.0, 57578.0, 57867.71066144642, 57922.7103864478, 58012.70993645089, 1073.8831615120343, 1160.4893846707253, 1347.1041757231528, 1369.5959691890716, 1401.9579412617638, 25979.350516237246, 29010.274743130747, 29789.702102978692, 29844.403111938074, 30372.84813575918, 50346.0, 50427.74786126046, 50935.235971461196, 50972.23541646953, 51080.72298192575, 475951.0, 554638.0, 558929.0, 561662.0, 561735.0, 26481.205563833115, 26817.731822681522, 26853.865730671223, 26877.731222688304, 26882.059127930428, 46290.53709462862, 46778.0, 46907.53092469032, 47976.0, 48016.27975580299, 32611.836940815145, 39319.82040538789, 41136.0, 41526.37710434286, 42120.0, 32949.50575741318, 38340.0, 38633.80683096567, 39333.80333098316, 39508.2098358037, 32499.0, 37961.43057854079, 38016.85949421522, 38340.80829595834, 40524.79737601293, 32048.839755801073, 34645.13387165341, 35039.82480087583, 35383.64616353803, 35431.0, 25154.62268065944, 25289.62065569055, 25384.41335771367, 25764.484710305314, 25768.09811656583], "value": 19885.596855563144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.46345796817917, 369.4107897902846, 372.71301098154424, 384.46751249519406, 402.9617186367294, 19171.808281917176, 19652.606947861033, 20447.0, 20799.0, 21069.473263168427, 19436.70844937327, 19787.505312367197, 20761.792382076175, 20940.68588971163, 20947.476313092182, 5822.883542329151, 5875.794347197849, 6019.277686677605, 6034.426729460716, 6083.209182806229, 5908.822735317925, 5937.554683398741, 6003.649178934748, 6031.0, 6046.365131661179, 5634.0, 5886.234789477362, 5926.940730592682, 5973.581849270553, 5994.280686317648, 5897.498712609433, 5954.374790646984, 6006.339302676702, 6008.669523176223, 6021.066734656135, 5108.489151084862, 5186.273921650972, 5352.411234764173, 5428.782848686048, 5480.671159730429, 12482.50069997208, 12697.428615712315, 12705.491780328775, 12922.0, 12922.28927408992, 2049.3749406431034, 2062.267894897305, 2210.502636906683, 2361.2562042956415, 2853.9001134960176, 9440.386374885611, 9735.318527703064, 10088.546015429323, 12115.636530904087, 15281.930264881463, 1794.318159099534, 1840.6594779965749, 1849.9167537460846, 1881.8118188181209, 1891.0639233579466, 120311.0, 125224.99100035988, 128025.35987320004, 130523.0421543668, 143982.99999999895, 20105.0, 20450.590988180153, 20556.691649625267, 21037.158513659284, 21410.03654835536, 34454.655453445645, 34524.0, 34543.4818477723, 34625.48061779075, 34698.13254668603, 8568.314534837198, 10379.377237365783, 10653.680389588324, 10683.83974240387, 10823.83764243537, 8714.869276960851, 8776.91223087761, 8830.558472076498, 8941.955290223637, 8987.865182022275, 7810.218978102144, 7868.213178682086, 8626.0, 9563.569639366246, 9589.328746987643, 3206.631237407728, 3330.6169790474405, 3810.475809676096, 3831.7126215533945, 3841.385378339508, 377.6242638574581, 380.1579501404403, 693.5491930245381, 862.4092496639822, 870.3341943413294, 11046.502907369188, 11426.657200284004, 11673.416329183507, 11723.824142637868, 12082.57710980129, 423.3691799219141, 424.1262998223669, 424.7533489209181, 433.733254048764, 434.38534473719335, 9761.316707830383, 10866.239363244655, 11149.773524912252, 11952.820707689392, 12467.5012999479, 548093.0, 552268.0, 559806.0, 563996.0, 570516.0, 90532.0, 133180.3340983289, 133394.0, 134229.0, 136800.0, 989.8267803134422, 1005.637970330695, 1015.5582321689941, 1023.4626820918928, 1023.6110278094277, 17402.73895891588, 19145.52136196606, 19458.416247512596, 19470.221191152195, 19474.513137171685, 44265.0, 44772.10455790931, 56530.717346413, 58769.0, 58852.70573647104, 66959.0, 84259.5787021061, 84780.72828907694, 85182.57408712916, 85285.0, 6857.417119544894, 7245.311695388929, 7303.561786292839, 7806.41451891099, 8356.373272004503, 12037.037037037191, 12220.938895305822, 12239.0, 12643.747125057631, 12811.87188128144, 10539.894601053891, 10572.101371383518, 10672.733181670521, 10963.616273430393, 11239.943800280946, 10779.568817247222, 10944.299823142588, 11004.834927476255, 11018.50416731233, 11327.716807079889, 9334.953325233331, 11067.059299959272, 11169.050630696156, 11249.606263780728, 11377.2604780689, 6596.670166491752, 7616.162222155669, 7807.960960195162, 8088.514689118671, 8216.0, 10236.590536378462, 10697.14422846186, 10901.182411319342, 10982.505787239754, 10992.505337259683], "value": 9698.234495095163, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.3767679897644, 1566.342136302753, 1736.7481715151296, 1821.3625231169092, 1906.2375049980014, 8069.878951815713, 8356.247937685606, 8570.442921210124, 9128.995810460843, 9129.817403651932, 8558.871616925751, 8827.514486703229, 8838.116188381158, 8943.239824614915, 8976.8653470198, 2113.4610674278038, 2221.866687998717, 2341.262502311775, 2358.3396648938237, 2366.645003249509, 2325.8720770357622, 2350.189184731265, 2350.2831636350907, 2356.3637817789186, 2369.57347677418, 2326.7905888470036, 2333.0434521846046, 2344.0155134843408, 2354.6703461515403, 2358.186425683145, 2155.7305336832897, 2260.683504309398, 2304.4699719064624, 2310.3761984264324, 2320.303908827345, 2306.077568972408, 2307.9884600577057, 2311.711036120485, 2312.849664771801, 2321.5705094557393, 8899.065598112169, 8940.463572185625, 8977.820443591158, 8988.101189881025, 9018.458892466408, 5185.196294574347, 5313.867153321159, 5354.651947623392, 5355.544778693816, 5371.462853714636, 3414.1123307939865, 3473.548438702978, 3610.801405922673, 3619.710423166167, 3625.492431059654, 1043.4166630769264, 1060.612876300145, 1074.7152004718755, 1082.2532452607675, 1084.116445097251, 10519.368837869752, 11671.007964323127, 11849.940750296193, 11865.940670296593, 11940.761184776256, 4045.8786236412957, 4554.362389265505, 4794.113089078532, 4836.322914791932, 4852.660313778002, 10053.949730251303, 10120.443375614412, 10128.59485620567, 10141.797164056678, 10155.593776248867, 5295.258663786996, 5362.1420572708175, 5368.7047212403695, 5399.541039011649, 5401.1358182691365, 4411.867643970686, 4588.449386073693, 4729.905401891943, 4878.414590249193, 4929.334539837076, 3902.90242743928, 3939.6060393960947, 3969.8412063517135, 4036.737612055266, 4128.690348223895, 1301.466398776516, 1304.562971404571, 1309.43039777697, 1315.1057281048788, 1316.2694704439127, 820.9179082091744, 912.3522299167532, 915.4232833314969, 922.1424075609748, 956.4691596164196, 5759.395263497357, 5863.941360586425, 5926.970365148147, 6022.57841951068, 6154.046122850965, 363.58914426697663, 890.8797312362877, 993.5082134343546, 1007.5163921317809, 1057.830747080479, 3943.2310699413338, 3997.080671445584, 4072.511298644182, 4100.138970816162, 4113.588641135862, 10512.947435262928, 10776.67669969902, 10811.945940270249, 10876.021158095651, 10909.127269818395, 10779.730506737238, 10794.082502987334, 10801.189910756568, 10838.458077096113, 10860.511276992554, 7707.075150981918, 7951.522908625501, 8176.264136227768, 8224.177582241728, 8260.586970651324, 5848.5028772553105, 5852.970735146297, 5873.471387575139, 5987.371326010881, 6043.395660433922, 7859.292663660298, 9689.612415503301, 9699.563519641491, 9769.560369783234, 9784.755381115529, 9575.04249575037, 9728.429523823519, 9867.06262905023, 9871.654492092743, 9877.012298770065, 7029.29707029293, 7204.0, 7253.202147763847, 7528.473006889684, 7675.808104797201, 8066.435349525712, 8233.217844304781, 8356.623951922056, 8370.665173392996, 8383.329333653415, 7181.784546463615, 7401.296876796696, 7405.925940740739, 7461.440391970733, 7594.544327340377, 7241.818954526179, 7300.050993370828, 7404.925950740424, 7490.4007679386605, 7491.925080749123, 7014.894776578253, 7066.328698773608, 7133.8929916050265, 7140.7857764267155, 7162.319579639926, 4907.386576677915, 4973.577245934136, 5012.147934851011, 5079.492050794891, 5101.846944591668, 4841.2496063110275, 4845.781939812647, 4970.577500912463, 4999.250112483157, 5109.565686916654], "value": 4580.668036709435, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.84048932597744, 290.2004976290319, 296.962879640045, 307.86761692472237, 313.68161316263996, 4886.755662216893, 5410.404855465896, 5513.586481013925, 5529.751161197751, 5586.497215250627, 4980.252962055693, 5185.833187532803, 5301.549368303689, 5317.707526086064, 5498.0, 4225.197212529617, 4257.318828987362, 4293.09844932563, 4297.785110744466, 4306.956930430702, 3767.660910518053, 4218.3250679891225, 4280.550542193072, 4284.271673815459, 4346.978460061899, 4187.476565429321, 4194.266003449399, 4204.0, 4221.620054195122, 4279.764612946286, 4255.319148936171, 4257.59552842481, 4271.953371424021, 4273.871783846458, 4292.484901811803, 3574.8439826088497, 3700.5374328208973, 3705.4071348584366, 3716.609755975611, 3738.3831667774784, 4100.897477563055, 4792.760361981887, 5461.399246082928, 5479.1781232815, 5504.256925315071, 4909.7790599423115, 4917.680350777188, 4924.015196960587, 4928.359313289249, 4934.555889969884, 4678.789454474523, 5588.826346467246, 5832.0, 5922.674252916088, 5923.911141332884, 3703.1112532992156, 3927.725059245854, 3935.704822138351, 3937.2125574885135, 3945.3687410014545, 4980.936723914766, 5345.679259244458, 5858.326292476335, 6214.720337584819, 6220.47125994291, 3985.940210896839, 3990.20195960809, 3996.5803590623145, 4006.4759201703323, 4009.7393669411395, 3615.9276814463565, 3719.8512059517857, 3979.0, 4059.512858456945, 4069.1861627674584, 4312.568743125662, 4528.46406012634, 4751.434225518251, 4776.376032149086, 4783.278019912828, 4776.47458779534, 4975.601951843843, 5967.343592204854, 5969.970150149222, 5990.0, 1226.5523084074248, 1291.141390974991, 1334.5329134802935, 1362.9591112266648, 1373.7183877305129, 834.5910503853069, 899.9820003599891, 911.2755359489222, 922.8154369126202, 924.4360939826701, 5634.267545219177, 5641.843422098542, 5645.096784514458, 5646.85882852932, 5703.62926409782, 4941.827036053721, 5410.322799932033, 5733.3406658234835, 5912.906112369139, 6204.875902482016, 4634.331640609378, 4776.307435421914, 4793.424789025269, 5469.206964990134, 5680.346760122557, 2484.850908945469, 2559.7184309725917, 2682.015308671569, 2758.6413766210667, 2768.1972228053637, 4482.9775851121185, 4896.037897072291, 5307.389650190277, 5349.625526213205, 5357.624966252325, 4569.9314510282375, 5094.777253459143, 5755.913661295084, 6339.936600634027, 6393.6163830170335, 6459.450946669585, 6489.902651460232, 6501.024846273097, 6549.541532092708, 6552.246491653425, 5418.234327142755, 5880.647161170173, 5950.702464876826, 6223.693024464913, 6244.250689917239, 5099.6175286852895, 6068.605540639845, 6069.089636554552, 6076.939230607637, 6149.907751383644, 6408.487321014214, 6409.0, 6415.369698423624, 6437.935620643733, 6514.283428822731, 3503.719702423851, 3699.225580814389, 3722.739408241397, 3931.410288456754, 3999.3001224786126, 5102.974485127551, 6157.384261573807, 6175.289841668266, 6178.289496707756, 6183.84540386494, 5813.970930145322, 5897.115432685132, 5968.8806223876145, 5981.940180598138, 5984.760609575568, 5009.348784657971, 5933.881322373442, 5953.196318497121, 5979.641221526722, 5988.341282458839, 4840.709557426425, 5052.9388828346455, 5759.96320662268, 5807.651540907559, 5864.472197502245, 4950.801967921243, 5640.32316122068, 5781.682007489629, 5913.379095194942, 6028.3971602839365, 5133.486651334837, 5179.48205179479, 5438.129899216106, 5717.256756621613, 5868.618539794899], "value": 4227.381058735906, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.251517164563, 750.2197714377048, 759.4418102694518, 762.6377470701417, 802.9076656184538, 15140.394384224632, 16202.918985405086, 16372.754408683879, 16375.754363684555, 16449.424270150546, 14848.331825067871, 15434.768478472832, 15897.205139743024, 16048.59878503038, 16534.83465165348, 874.5277550122942, 899.5502248875562, 899.7480705402497, 901.4185850126664, 901.4726385064712, 713.6039498078565, 738.3723834740481, 871.6949067826273, 896.5158814240302, 900.4822227219342, 947.1948843483019, 965.657191696948, 967.6274634265823, 969.0261287406147, 969.3505351414569, 963.2679163835465, 964.4309857184295, 964.9565769540352, 965.165132160683, 967.3808762392075, 705.0552259971612, 714.3535100733844, 715.7781087862727, 717.2827172827173, 721.7077083781077, 15589.610259743484, 15728.213589320489, 15956.441524546584, 16037.198140093065, 16081.437149699705, 11347.375894325809, 13836.377363018688, 14254.857451425456, 14492.565223043326, 14498.71002579953, 11823.290602563873, 11953.760924781544, 12053.63839084829, 12129.272243665408, 12306.630801075982, 3581.910452238689, 3719.609441008682, 3745.4970062855527, 3763.435484677293, 3905.9218815623813, 119052.40473797663, 119579.4021029898, 119751.0, 121094.0, 121783.3910830449, 10614.203934704774, 10662.573497060032, 10743.946280268548, 10786.406747628957, 10823.404712740718, 16418.589535261715, 19936.0, 20959.68560471594, 21176.78823211779, 21181.576368472543, 7839.0, 7965.8805117923275, 8028.518288902685, 8048.718294859652, 8117.594120293962, 4383.7808109595035, 4544.136614043321, 4592.334111553806, 4615.930761038587, 4619.792109355087, 3633.3823250047553, 3697.0942119180972, 3744.475773391727, 3747.1568896997956, 3750.1562148516364, 658.8451713847242, 670.9834600580125, 716.7419728897593, 720.5784615999594, 757.9469437139458, 558.5196730811499, 589.9882002360015, 609.4636719686647, 650.3009265040006, 700.1003710232327, 8582.485050896967, 9225.12361325673, 9489.66786162481, 9670.903290967, 9971.551280192409, 586.519054375408, 609.960352577081, 636.5830381100386, 679.5175425447987, 681.6114814555656, 4399.956000440018, 4668.11305851887, 4690.390249267573, 4739.881502962385, 4773.9761301193275, 100627.0, 138477.0, 161144.0, 163390.3660963375, 166028.0, 135716.0, 137219.0, 142939.0, 143905.0, 143909.8413523798, 75096.0, 92920.07079929115, 96235.0, 104321.47839260907, 110930.44534777275, 9406.858897116686, 9926.354786938826, 9927.305088644014, 9970.155521228597, 9977.151942084714, 63783.362166377745, 63803.36196637974, 65504.672476637315, 65875.67062164658, 67185.25813757075, 92459.07540924505, 95081.0, 96253.0, 100077.0, 100122.4993875026, 12451.128421010442, 12815.359232038547, 13090.934545327593, 13139.54011609589, 13311.068225224142, 11794.0, 12548.749025019266, 14569.198694071927, 14799.92600036993, 15308.617284567976, 13429.992750543553, 13566.118202316818, 13653.795193071914, 14320.928395358373, 14331.996760226684, 13419.731605368033, 13553.525626603416, 13671.726565468436, 13673.521426750414, 14102.36539355711, 11412.771744565229, 13706.93146534261, 13966.650833729238, 13993.440262389391, 14129.293535323399, 11256.662300131009, 11435.085193184359, 11437.142214334124, 11458.484368203617, 11576.0, 7194.460415468965, 10166.390016599027, 10763.51564179598, 11293.943530282297, 11645.59240426581], "value": 7950.190083273077, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1597.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 118.0, 118.0, 115.0, 118.0, 118.0, 117.0, 117.0, 120.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 145.0, 154.0, 145.0, 108.0, 145.0, 152.0, 177.0, 114.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 206.0, 224.0, 202.0, 195.0, 197.0, 198.0, 198.0, 233.0, 211.0], "value": 206.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 59.0, 58.0, 86.0, 58.0, 58.0, 58.0, 59.0, 93.0, 84.0], "value": 69.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 84.0, 58.0, 65.0, 76.0, 125.0, 99.0, 102.0, 73.0], "value": 83.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 97.0, 120.0, 90.0, 87.0, 91.0, 76.0, 120.0, 129.0], "value": 98.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 99.0, 100.0, 98.0, 99.0, 99.0, 133.0, 172.0, 100.0], "value": 109.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 136.0, 114.0, 139.0, 130.0, 89.0, 138.0, 103.0, 110.0, 89.0], "value": 111.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 61.0, 79.0, 89.0, 90.0, 50.0, 50.0, 81.0, 78.0], "value": 69.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 79.0, 79.0, 76.0, 68.0, 70.0, 70.0, 70.0, 76.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 99.0, 106.0, 109.0, 111.0, 103.0, 91.0, 104.0, 90.0], "value": 98.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 140.0, 156.0, 165.0, 163.0, 150.0, 179.0, 160.0, 208.0, 158.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 175.0, 171.0, 175.0, 173.0, 173.0, 192.0, 176.0, 232.0, 185.0], "value": 184.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 82.0, 89.0, 73.0, 63.0, 63.0, 87.0, 64.0, 71.0, 77.0], "value": 72.9, "unit": "score"}]}]} 20:37:29 INFO - Return code: 0 20:37:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:37:29 ERROR - # TBPL SUCCESS # 20:37:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:37:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:37:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:37:29 INFO - 2016-10-23 20:37:29.676 screenresolution[1666:10326] starting screenresolution argv=screenresolution get 20:37:29 INFO - 2016-10-23 20:37:29.679 screenresolution[1666:10326] Display 0: 1600x1200x32@60 20:37:29 INFO - 2016-10-23 20:37:29.684 screenresolution[1667:10329] starting screenresolution argv=screenresolution list 20:37:29 INFO - Available Modes on Display 0 20:37:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:37:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:37:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:37:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:37:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:37:29 INFO - Intel Iris: 20:37:29 INFO - Chipset Model: Intel Iris 20:37:29 INFO - Type: GPU 20:37:29 INFO - Bus: Built-In 20:37:29 INFO - VRAM (Dynamic, Max): 1536 MB 20:37:29 INFO - Vendor: Intel (0x8086) 20:37:29 INFO - Device ID: 0x0a2e 20:37:29 INFO - Revision ID: 0x0009 20:37:29 INFO - Displays: 20:37:29 INFO - Display: 20:37:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:37:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:37:29 INFO - Display Serial Number: 1600x1200 60 20:37:29 INFO - Main Display: Yes 20:37:29 INFO - Mirror: Off 20:37:29 INFO - Online: Yes 20:37:29 INFO - Rotation: Supported 20:37:29 INFO - Return code: 0 20:37:29 INFO - Running post-action listener: _resource_record_post_action 20:37:29 INFO - [mozharness: 2016-10-24 03:37:29.921698Z] Finished run-tests step (success) 20:37:29 INFO - Running post-run listener: _resource_record_post_run 20:37:29 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 39773696; Write bytes: 705870848; Read time: 409; Write time: 2029 20:37:29 INFO - TinderboxPrint: CPU usage
54.6% 20:37:29 INFO - TinderboxPrint: I/O read bytes / time
39,773,696 / 409 20:37:29 INFO - TinderboxPrint: I/O write bytes / time
705,870,848 / 2,029 20:37:29 INFO - TinderboxPrint: CPU idle
2,199.6 (45.4%) 20:37:29 INFO - TinderboxPrint: CPU system
980.5 (20.2%) 20:37:29 INFO - TinderboxPrint: CPU user
1,665.6 (34.4%) 20:37:29 INFO - TinderboxPrint: Swap in / out
444,129,280 / 0 20:37:29 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399856128; Write bytes: 393283584; Read time: 29665; Write time: 692 20:37:29 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 37672448; Write bytes: 298177536; Read time: 385; Write time: 1296 20:37:30 INFO - Running post-run listener: _upload_blobber_files 20:37:30 INFO - Blob upload gear active. 20:37:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:37:30 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 20:37:30 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:37:30 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:37:30 INFO - (blobuploader) - INFO - Open directory for files ... 20:37:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:37:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:37:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:37:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:37:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:37:32 INFO - (blobuploader) - INFO - Done attempting. 20:37:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:37:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:37:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:37:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:37:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:37:33 INFO - (blobuploader) - INFO - Done attempting. 20:37:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:37:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:37:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:37:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:37:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:37:35 INFO - (blobuploader) - INFO - Done attempting. 20:37:35 INFO - (blobuploader) - INFO - Iteration through files over. 20:37:35 INFO - Return code: 0 20:37:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:37:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:37:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2afde35f94fee884c9f1b167185bdd6151be03601d1521dbe8080e846e50c24da88ae77601d4e9193ab6a1d2492aea7af6c415a940f555271dcf6374d6e9f043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63410c9a155e3fe0dd63782aed14efb917907fe0559681b9cb511f2b7b55764feb2028da33c614f97cd2c057b3c5c4e2e26d576c9dac14f723b13c2c8455e164", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8808c3647153b98464738a2441f5810d41968552a6afd3202af1a18953fdeeaa4cc4fa72cb0cc65d6800c437e740b177a746afafd22ad6cb79ff461b6bdc5478"} 20:37:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:37:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:37:35 INFO - Contents: 20:37:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2afde35f94fee884c9f1b167185bdd6151be03601d1521dbe8080e846e50c24da88ae77601d4e9193ab6a1d2492aea7af6c415a940f555271dcf6374d6e9f043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63410c9a155e3fe0dd63782aed14efb917907fe0559681b9cb511f2b7b55764feb2028da33c614f97cd2c057b3c5c4e2e26d576c9dac14f723b13c2c8455e164", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8808c3647153b98464738a2441f5810d41968552a6afd3202af1a18953fdeeaa4cc4fa72cb0cc65d6800c437e740b177a746afafd22ad6cb79ff461b6bdc5478"} 20:37:35 INFO - Running post-run listener: copy_logs_to_upload_dir 20:37:35 INFO - Copying logs to upload dir... 20:37:35 INFO - mkdir: /builds/slave/test/build/upload/logs 20:37:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.430226 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-23 20:37:35.914623) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 20:37:35.918876) ========= 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.rvnfa2RrzO/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.tZGZX4E2d4/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2afde35f94fee884c9f1b167185bdd6151be03601d1521dbe8080e846e50c24da88ae77601d4e9193ab6a1d2492aea7af6c415a940f555271dcf6374d6e9f043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63410c9a155e3fe0dd63782aed14efb917907fe0559681b9cb511f2b7b55764feb2028da33c614f97cd2c057b3c5c4e2e26d576c9dac14f723b13c2c8455e164", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8808c3647153b98464738a2441f5810d41968552a6afd3202af1a18953fdeeaa4cc4fa72cb0cc65d6800c437e740b177a746afafd22ad6cb79ff461b6bdc5478"} build_url:https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011122 build_url: 'https://queue.taskcluster.net/v1/task/Q_4zx7E7TOuhWR38I1NY9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2afde35f94fee884c9f1b167185bdd6151be03601d1521dbe8080e846e50c24da88ae77601d4e9193ab6a1d2492aea7af6c415a940f555271dcf6374d6e9f043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63410c9a155e3fe0dd63782aed14efb917907fe0559681b9cb511f2b7b55764feb2028da33c614f97cd2c057b3c5c4e2e26d576c9dac14f723b13c2c8455e164", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8808c3647153b98464738a2441f5810d41968552a6afd3202af1a18953fdeeaa4cc4fa72cb0cc65d6800c437e740b177a746afafd22ad6cb79ff461b6bdc5478"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 20:37:35.949546) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 20:37:35.949857) ========= 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.rvnfa2RrzO/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.tZGZX4E2d4/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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.005017 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 20:37:35.998385) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 20:37:35.998723) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 20:37:35.999057) ========= ========= Total master_lag: 0.17 =========