builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0096 starttime: 1477515052.54 results: success (0) buildid: 20161026075526 builduid: 1b6e62fa11104b93a83fb80681645e95 revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.545299) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.546294) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.546570) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.609608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.609918) ========= 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.d7O0CfrPAy/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.vPDqDHS9qt/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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-26 13:50:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.14M=0.001s 2016-10-26 13:50:52 (8.14 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105376 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.742138) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.742463) ========= 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.d7O0CfrPAy/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.vPDqDHS9qt/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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.026991 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.791175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 13:50:52.791531) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d7O0CfrPAy/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.vPDqDHS9qt/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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-26 13:50:52,863 truncating revision to first 12 chars 2016-10-26 13:50:52,863 Setting DEBUG logging. 2016-10-26 13:50:52,863 attempt 1/10 2016-10-26 13:50:52,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d26ac63f1b81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 13:50:53,885 unpacking tar archive at: mozilla-central-d26ac63f1b81/testing/mozharness/ program finished with exit code 0 elapsedTime=1.282685 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 13:50:54.095124) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.095411) ========= script_repo_revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.095766) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.096030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.114061) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-26 13:50:54.114371) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d7O0CfrPAy/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.vPDqDHS9qt/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:50:54 INFO - MultiFileLogger online at 20161026 13:50:54 in /builds/slave/test 13:50:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:50:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:50:54 INFO - {'append_to_log': False, 13:50:54 INFO - 'base_work_dir': '/builds/slave/test', 13:50:54 INFO - 'blob_upload_branch': 'Firefox', 13:50:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:50:54 INFO - 'branch': 'Firefox', 13:50:54 INFO - 'buildbot_json_path': 'buildprops.json', 13:50:54 INFO - 'config_files': ('talos/mac_config.py',), 13:50:54 INFO - 'default_actions': ('clobber', 13:50:54 INFO - 'read-buildbot-config', 13:50:54 INFO - 'download-and-extract', 13:50:54 INFO - 'populate-webroot', 13:50:54 INFO - 'create-virtualenv', 13:50:54 INFO - 'install', 13:50:54 INFO - 'run-tests'), 13:50:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:50:54 INFO - 'download_minidump_stackwalk': True, 13:50:54 INFO - 'download_symbols': 'ondemand', 13:50:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:50:54 INFO - 'tooltool.py': '/tools/tooltool.py', 13:50:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:50:54 INFO - '/tools/misc-python/virtualenv.py')}, 13:50:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:50:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:50:54 INFO - 'installer_path': 'installer.exe', 13:50:54 INFO - 'log_level': 'info', 13:50:54 INFO - 'log_name': 'talos', 13:50:54 INFO - 'log_to_console': True, 13:50:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:50:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:50:54 INFO - 'opt_config_files': (), 13:50:54 INFO - 'pip_index': False, 13:50:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:54 INFO - 'cmd': ('bash', 13:50:54 INFO - '-c', 13:50:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:54 INFO - 'enabled': True, 13:50:54 INFO - 'halt_on_failure': False, 13:50:54 INFO - 'name': 'check_screen_resolution'},), 13:50:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:54 INFO - 'cmd': ('bash', 13:50:54 INFO - '-c', 13:50:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:54 INFO - 'enabled': True, 13:50:54 INFO - 'halt_on_failure': False, 13:50:54 INFO - 'name': 'check_screen_resolution'},), 13:50:54 INFO - 'run_cmd_checks_enabled': True, 13:50:54 INFO - 'sps_profile': False, 13:50:54 INFO - 'sps_profile_interval': 0, 13:50:54 INFO - 'suite': 'dromaeojs-e10s', 13:50:54 INFO - 'system_bits': '32', 13:50:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:50:54 INFO - 'title': 't-yosemite-r7-0096', 13:50:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:50:54 INFO - 'use_talos_json': True, 13:50:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:50:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:50:54 INFO - 'work_dir': 'build'} 13:50:54 INFO - [mozharness: 2016-10-26 20:50:54.317702Z] Running clobber step. 13:50:54 INFO - Running pre-action listener: _resource_record_pre_action 13:50:54 INFO - Running main action method: clobber 13:50:54 INFO - rmtree: /builds/slave/test/build 13:50:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:50:56 INFO - Running post-action listener: _resource_record_post_action 13:50:56 INFO - [mozharness: 2016-10-26 20:50:56.502424Z] Finished clobber step (success) 13:50:56 INFO - [mozharness: 2016-10-26 20:50:56.502620Z] Running read-buildbot-config step. 13:50:56 INFO - Running pre-action listener: _resource_record_pre_action 13:50:56 INFO - Running main action method: read_buildbot_config 13:50:56 INFO - Using buildbot properties: 13:50:56 INFO - { 13:50:56 INFO - "project": "", 13:50:56 INFO - "product": "firefox", 13:50:56 INFO - "script_repo_revision": "production", 13:50:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:50:56 INFO - "repository": "", 13:50:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:50:56 INFO - "buildid": "20161026075526", 13:50:56 INFO - "pgo_build": "False", 13:50:56 INFO - "basedir": "/builds/slave/test", 13:50:56 INFO - "buildnumber": 50, 13:50:56 INFO - "slavename": "t-yosemite-r7-0096", 13:50:56 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:50:56 INFO - "platform": "yosemite_r7", 13:50:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:50:56 INFO - "branch": "mozilla-central", 13:50:56 INFO - "repo_path": "mozilla-central", 13:50:56 INFO - "revision": "d26ac63f1b81c3fce35448a7c502e95e0b5c56c0", 13:50:56 INFO - "stage_platform": "macosx64", 13:50:56 INFO - "builduid": "1b6e62fa11104b93a83fb80681645e95", 13:50:56 INFO - "slavebuilddir": "test" 13:50:56 INFO - } 13:50:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:50:56 INFO - Running post-action listener: _resource_record_post_action 13:50:56 INFO - [mozharness: 2016-10-26 20:50:56.506151Z] Finished read-buildbot-config step (success) 13:50:56 INFO - [mozharness: 2016-10-26 20:50:56.506301Z] Running download-and-extract step. 13:50:56 INFO - Running pre-action listener: _resource_record_pre_action 13:50:56 INFO - Running main action method: download_and_extract 13:50:56 INFO - mkdir: /builds/slave/test/build/tests 13:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:56 INFO - trying https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:56 INFO - Downloading https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/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 13:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/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 13:50:57 INFO - Downloaded 1199 bytes. 13:50:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:57 INFO - Using the following test package requirements: 13:50:57 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:50:57 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:57 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:50:57 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:57 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:50:57 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:57 INFO - u'jsshell-mac.zip'], 13:50:57 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:57 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:50:57 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:50:57 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:57 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:50:57 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:57 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:50:57 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:57 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:50:57 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:57 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:50:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:50:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:50:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:50:57 INFO - Fetch https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:50:58 INFO - Http code: 200 13:50:58 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 13:50:58 INFO - x-amz-cf-id: irMZunAw_gnPitR8RPUVPCAQ9-8H5A5soQoY6OxH_8hxmw-XCzds6g== 13:50:58 INFO - x-amz-version-id: oYs0S0BWLue4d5yNfzrDOVXSMP0of8m4 13:50:58 INFO - Expected file size: 16442708 13:50:58 INFO - Obtained file size: 16442708 13:51:05 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 13:51:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:51:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:51:05 INFO - Fetch https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:51:06 INFO - Http code: 200 13:51:06 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 13:51:06 INFO - x-amz-cf-id: A6Y1UfuQT2RhXlcmvfFDY0mDNiRZZ5k_PUK9K9RZ4IcqdZxrRuD2Ug== 13:51:06 INFO - x-amz-version-id: oYs0S0BWLue4d5yNfzrDOVXSMP0of8m4 13:51:06 INFO - Expected file size: 16442708 13:51:06 INFO - Obtained file size: 16442708 13:51:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 13:51:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:51:12 INFO - Fetch https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 13:51:13 INFO - Http code: 200 13:51:13 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 13:51:13 INFO - x-amz-cf-id: rWjexaZW2eOFrBmO8zO2u5eoZUaNhXClCNosYbY-hdVXqEYxaVZllw== 13:51:13 INFO - x-amz-version-id: 0bXUQ92dp_r4joro14ZW7j22G0F3vbr6 13:51:13 INFO - Expected file size: 14409028 13:51:13 INFO - Obtained file size: 14409028 13:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:13 INFO - trying https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:13 INFO - Downloading https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 13:51:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/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 13:51:16 INFO - Downloaded 111730824 bytes. 13:51:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:16 INFO - mkdir: /builds/slave/test/properties 13:51:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:51:16 INFO - Writing to file /builds/slave/test/properties/build_url 13:51:16 INFO - Contents: 13:51:16 INFO - build_url:https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:17 INFO - Running post-action listener: _resource_record_post_action 13:51:17 INFO - Running post-action listener: set_extra_try_arguments 13:51:17 INFO - [mozharness: 2016-10-26 20:51:17.647148Z] Finished download-and-extract step (success) 13:51:17 INFO - [mozharness: 2016-10-26 20:51:17.647273Z] Running populate-webroot step. 13:51:17 INFO - Running pre-action listener: _resource_record_pre_action 13:51:17 INFO - Running main action method: populate_webroot 13:51:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:51:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:51:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:51:17 INFO - '--tppagecycles', 13:51:17 INFO - '7'], 13:51:17 INFO - 'tests': ['tsvgm']}}, 13:51:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:51:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:51:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:51:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:51:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:51:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:51:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:17 INFO - 'talos_options': ['--disable-e10s'], 13:51:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:17 INFO - 'talos_options': ['--disable-e10s'], 13:51:17 INFO - 'tests': ['damp', 'tps']}, 13:51:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:17 INFO - 'tests': ['damp', 'tps']}, 13:51:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:51:17 INFO - 'tests': ['dromaeo_dom']}, 13:51:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:51:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:51:17 INFO - 'tests': ['basic_compositor_video']}, 13:51:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:51:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:51:17 INFO - 'tests': ['a11yr', 13:51:17 INFO - 'ts_paint', 13:51:17 INFO - 'tpaint', 13:51:17 INFO - 'sessionrestore', 13:51:17 INFO - 'sessionrestore_no_auto_restore', 13:51:17 INFO - 'tabpaint']}, 13:51:17 INFO - 'other-e10s': {'tests': ['a11yr', 13:51:17 INFO - 'ts_paint', 13:51:17 INFO - 'tpaint', 13:51:17 INFO - 'sessionrestore', 13:51:17 INFO - 'sessionrestore_no_auto_restore', 13:51:17 INFO - 'tabpaint']}, 13:51:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:51:17 INFO - 'ts_paint', 13:51:17 INFO - 'tpaint', 13:51:17 INFO - 'sessionrestore', 13:51:17 INFO - 'sessionrestore_no_auto_restore', 13:51:17 INFO - 'tabpaint']}, 13:51:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:51:17 INFO - 'ts_paint', 13:51:17 INFO - 'tpaint', 13:51:17 INFO - 'sessionrestore', 13:51:17 INFO - 'sessionrestore_no_auto_restore', 13:51:17 INFO - 'tabpaint']}, 13:51:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:51:17 INFO - 'tests': ['a11yr', 13:51:17 INFO - 'ts_paint', 13:51:17 INFO - 'tpaint', 13:51:17 INFO - 'sessionrestore', 13:51:17 INFO - 'sessionrestore_no_auto_restore', 13:51:17 INFO - 'tabpaint']}, 13:51:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:51:17 INFO - 'tests': ['a11yr', 13:51:17 INFO - 'ts_paint', 13:51:17 INFO - 'tpaint', 13:51:17 INFO - 'sessionrestore', 13:51:17 INFO - 'sessionrestore_no_auto_restore', 13:51:17 INFO - 'tabpaint']}, 13:51:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:51:17 INFO - 'tests': ['tsvgx', 13:51:17 INFO - 'tsvgr_opacity', 13:51:17 INFO - 'tart', 13:51:17 INFO - 'tscrollx', 13:51:17 INFO - 'cart']}, 13:51:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:51:17 INFO - 'tsvgr_opacity', 13:51:17 INFO - 'tart', 13:51:17 INFO - 'tscrollx', 13:51:17 INFO - 'cart']}, 13:51:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:17 INFO - 'talos_options': ['--disable-e10s'], 13:51:17 INFO - 'tests': ['tp5o']}, 13:51:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:17 INFO - 'tests': ['tp5o']}, 13:51:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:17 INFO - 'talos_options': ['--disable-e10s', 13:51:17 INFO - '--xperf_path', 13:51:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:17 INFO - 'tests': ['tp5n']}, 13:51:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:17 INFO - 'talos_options': ['--xperf_path', 13:51:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:17 INFO - 'tests': ['tp5n']}}, 13:51:17 INFO - 'talos.zip': {'path': '', 13:51:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:51:17 INFO - Running post-action listener: _resource_record_post_action 13:51:17 INFO - [mozharness: 2016-10-26 20:51:17.665869Z] Finished populate-webroot step (success) 13:51:17 INFO - [mozharness: 2016-10-26 20:51:17.665997Z] Running create-virtualenv step. 13:51:17 INFO - Running pre-action listener: _resource_record_pre_action 13:51:17 INFO - Running main action method: create_virtualenv 13:51:17 INFO - Creating virtualenv /builds/slave/test/build/venv 13:51:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:51:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:51:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:51:17 INFO - Using real prefix '/tools/python27' 13:51:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:51:18 INFO - Installing distribute.............................................................................................................................................................................................done. 13:51:21 INFO - Installing pip.................done. 13:51:21 INFO - Return code: 0 13:51:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:51:21 INFO - Reading from file tmpfile_stdout 13:51:21 INFO - Output received: 13:51:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:51:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10664a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b8945cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064e8d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064e0b20>, '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.d7O0CfrPAy/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.vPDqDHS9qt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:51:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d7O0CfrPAy/Render', 13:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:21 INFO - 'HOME': '/Users/cltbld', 13:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:21 INFO - 'LOGNAME': 'cltbld', 13:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:21 INFO - 'MOZ_NO_REMOTE': '1', 13:51:21 INFO - 'NO_EM_RESTART': '1', 13:51:21 INFO - 'PAGER': '/bin/cat', 13:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:21 INFO - 'PWD': '/builds/slave/test', 13:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:21 INFO - 'SHELL': '/bin/bash', 13:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vPDqDHS9qt/Listeners', 13:51:21 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 13:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:21 INFO - 'USER': 'cltbld', 13:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:21 INFO - 'XPC_FLAGS': '0x0', 13:51:21 INFO - 'XPC_SERVICE_NAME': '0', 13:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:51:21 INFO - Cleaning up... 13:51:21 INFO - Return code: 0 13:51:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10664a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b8945cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064e8d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064e0b20>, '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.d7O0CfrPAy/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.vPDqDHS9qt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:51:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d7O0CfrPAy/Render', 13:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:21 INFO - 'HOME': '/Users/cltbld', 13:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:21 INFO - 'LOGNAME': 'cltbld', 13:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:21 INFO - 'MOZ_NO_REMOTE': '1', 13:51:21 INFO - 'NO_EM_RESTART': '1', 13:51:21 INFO - 'PAGER': '/bin/cat', 13:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:21 INFO - 'PWD': '/builds/slave/test', 13:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:21 INFO - 'SHELL': '/bin/bash', 13:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vPDqDHS9qt/Listeners', 13:51:21 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 13:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:21 INFO - 'USER': 'cltbld', 13:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:21 INFO - 'XPC_FLAGS': '0x0', 13:51:21 INFO - 'XPC_SERVICE_NAME': '0', 13:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:22 INFO - Downloading/unpacking psutil>=3.1.1 13:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:51:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:25 INFO - Installing collected packages: psutil 13:51:25 INFO - Running setup.py install for psutil 13:51:25 INFO - building 'psutil._psutil_osx' extension 13:51:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:51:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:51:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:51:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:51:26 INFO - building 'psutil._psutil_posix' extension 13:51:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:51:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:51:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:51:26 INFO - ^ 13:51:26 INFO - 1 warning generated. 13:51:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:51:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:26 INFO - Successfully installed psutil 13:51:26 INFO - Cleaning up... 13:51:27 INFO - Return code: 0 13:51:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:27 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 0x1066d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10664a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b8945cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064e8d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064e0b20>, '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.d7O0CfrPAy/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.vPDqDHS9qt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:51:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d7O0CfrPAy/Render', 13:51:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:27 INFO - 'HOME': '/Users/cltbld', 13:51:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:27 INFO - 'LOGNAME': 'cltbld', 13:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:27 INFO - 'MOZ_NO_REMOTE': '1', 13:51:27 INFO - 'NO_EM_RESTART': '1', 13:51:27 INFO - 'PAGER': '/bin/cat', 13:51:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:27 INFO - 'PWD': '/builds/slave/test', 13:51:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:27 INFO - 'SHELL': '/bin/bash', 13:51:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vPDqDHS9qt/Listeners', 13:51:27 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 13:51:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:27 INFO - 'USER': 'cltbld', 13:51:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:27 INFO - 'XPC_FLAGS': '0x0', 13:51:27 INFO - 'XPC_SERVICE_NAME': '0', 13:51:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:51:29 INFO - Installing collected packages: mozsystemmonitor 13:51:29 INFO - Running setup.py install for mozsystemmonitor 13:51:30 INFO - Successfully installed mozsystemmonitor 13:51:30 INFO - Cleaning up... 13:51:30 INFO - Return code: 0 13:51:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:30 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 0x1066d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10664a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b8945cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064e8d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064e0b20>, '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.d7O0CfrPAy/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.vPDqDHS9qt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d7O0CfrPAy/Render', 13:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:30 INFO - 'HOME': '/Users/cltbld', 13:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:30 INFO - 'LOGNAME': 'cltbld', 13:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:30 INFO - 'MOZ_NO_REMOTE': '1', 13:51:30 INFO - 'NO_EM_RESTART': '1', 13:51:30 INFO - 'PAGER': '/bin/cat', 13:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:30 INFO - 'PWD': '/builds/slave/test', 13:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:30 INFO - 'SHELL': '/bin/bash', 13:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vPDqDHS9qt/Listeners', 13:51:30 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 13:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:30 INFO - 'USER': 'cltbld', 13:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:30 INFO - 'XPC_FLAGS': '0x0', 13:51:30 INFO - 'XPC_SERVICE_NAME': '0', 13:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:30 INFO - Downloading/unpacking jsonschema==2.5.1 13:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:51:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:33 INFO - Downloading functools32-3.2.3-2.tar.gz 13:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:51:33 INFO - warning: no files found matching '*.txt' 13:51:33 INFO - no previously-included directories found matching 'build' 13:51:33 INFO - no previously-included directories found matching 'dist' 13:51:33 INFO - no previously-included directories found matching '.git*' 13:51:33 INFO - Installing collected packages: jsonschema, functools32 13:51:33 INFO - Running setup.py install for functools32 13:51:33 INFO - warning: no files found matching '*.txt' 13:51:33 INFO - no previously-included directories found matching 'build' 13:51:33 INFO - no previously-included directories found matching 'dist' 13:51:33 INFO - no previously-included directories found matching '.git*' 13:51:33 INFO - Successfully installed jsonschema functools32 13:51:33 INFO - Cleaning up... 13:51:33 INFO - Return code: 0 13:51:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10664a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b8945cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064e8d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064e0b20>, '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.d7O0CfrPAy/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.vPDqDHS9qt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d7O0CfrPAy/Render', 13:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:33 INFO - 'HOME': '/Users/cltbld', 13:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:33 INFO - 'LOGNAME': 'cltbld', 13:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:33 INFO - 'MOZ_NO_REMOTE': '1', 13:51:33 INFO - 'NO_EM_RESTART': '1', 13:51:33 INFO - 'PAGER': '/bin/cat', 13:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:33 INFO - 'PWD': '/builds/slave/test', 13:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:33 INFO - 'SHELL': '/bin/bash', 13:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vPDqDHS9qt/Listeners', 13:51:33 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 13:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:33 INFO - 'USER': 'cltbld', 13:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:33 INFO - 'XPC_FLAGS': '0x0', 13:51:33 INFO - 'XPC_SERVICE_NAME': '0', 13:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:51:33 INFO - Cleaning up... 13:51:33 INFO - Return code: 0 13:51:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10664a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b8945cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064e8d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064e0b20>, '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.d7O0CfrPAy/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.vPDqDHS9qt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d7O0CfrPAy/Render', 13:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:33 INFO - 'HOME': '/Users/cltbld', 13:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:33 INFO - 'LOGNAME': 'cltbld', 13:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:33 INFO - 'MOZ_NO_REMOTE': '1', 13:51:33 INFO - 'NO_EM_RESTART': '1', 13:51:33 INFO - 'PAGER': '/bin/cat', 13:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:33 INFO - 'PWD': '/builds/slave/test', 13:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:33 INFO - 'SHELL': '/bin/bash', 13:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vPDqDHS9qt/Listeners', 13:51:33 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 13:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:33 INFO - 'USER': 'cltbld', 13:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:33 INFO - 'XPC_FLAGS': '0x0', 13:51:33 INFO - 'XPC_SERVICE_NAME': '0', 13:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:34 INFO - Downloading/unpacking blobuploader==1.2.4 13:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:36 INFO - Downloading blobuploader-1.2.4.tar.gz 13:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:51:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:51:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:37 INFO - Downloading docopt-0.6.1.tar.gz 13:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:51:38 INFO - Installing collected packages: blobuploader, requests, docopt 13:51:38 INFO - Running setup.py install for blobuploader 13:51:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:51:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:51:38 INFO - Running setup.py install for requests 13:51:38 INFO - Running setup.py install for docopt 13:51:38 INFO - Successfully installed blobuploader requests docopt 13:51:38 INFO - Cleaning up... 13:51:38 INFO - Return code: 0 13:51:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10664a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b8945cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064e8d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064e0b20>, '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.d7O0CfrPAy/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.vPDqDHS9qt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:51:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d7O0CfrPAy/Render', 13:51:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:38 INFO - 'HOME': '/Users/cltbld', 13:51:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:38 INFO - 'LOGNAME': 'cltbld', 13:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:38 INFO - 'MOZ_NO_REMOTE': '1', 13:51:38 INFO - 'NO_EM_RESTART': '1', 13:51:38 INFO - 'PAGER': '/bin/cat', 13:51:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:38 INFO - 'PWD': '/builds/slave/test', 13:51:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:38 INFO - 'SHELL': '/bin/bash', 13:51:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vPDqDHS9qt/Listeners', 13:51:38 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 13:51:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:38 INFO - 'USER': 'cltbld', 13:51:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:38 INFO - 'XPC_FLAGS': '0x0', 13:51:38 INFO - 'XPC_SERVICE_NAME': '0', 13:51:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:39 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-TQm0mP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:39 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-I7YqzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:39 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-LJP3aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:39 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Vv71U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:39 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Q_MBhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:39 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-q_kBaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:39 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-oUvEtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:39 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-c5VR0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:39 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-KM_Pr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:40 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Mh7K4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:40 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-2IV9SM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:40 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-T9W4PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:40 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-pO43pA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:40 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-2bZ45B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:40 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-rUBlLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:40 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Rentpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:40 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-5yMLEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:51:40 INFO - Running setup.py install for manifestparser 13:51:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Running setup.py install for mozcrash 13:51:41 INFO - Running setup.py install for mozdebug 13:51:41 INFO - Running setup.py install for mozdevice 13:51:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Running setup.py install for mozfile 13:51:41 INFO - Running setup.py install for mozhttpd 13:51:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Running setup.py install for mozinfo 13:51:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Running setup.py install for mozInstall 13:51:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Running setup.py install for mozleak 13:51:42 INFO - Running setup.py install for mozlog 13:51:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Running setup.py install for moznetwork 13:51:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Running setup.py install for mozprocess 13:51:42 INFO - Running setup.py install for mozprofile 13:51:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Running setup.py install for mozrunner 13:51:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Running setup.py install for mozscreenshot 13:51:43 INFO - Running setup.py install for moztest 13:51:43 INFO - Running setup.py install for mozversion 13:51:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:51:43 INFO - Cleaning up... 13:51:43 INFO - Return code: 0 13:51:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10664a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b8945cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064e8d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064e0b20>, '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.d7O0CfrPAy/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.vPDqDHS9qt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:51:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d7O0CfrPAy/Render', 13:51:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:43 INFO - 'HOME': '/Users/cltbld', 13:51:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:43 INFO - 'LOGNAME': 'cltbld', 13:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:43 INFO - 'MOZ_NO_REMOTE': '1', 13:51:43 INFO - 'NO_EM_RESTART': '1', 13:51:43 INFO - 'PAGER': '/bin/cat', 13:51:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:43 INFO - 'PWD': '/builds/slave/test', 13:51:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:43 INFO - 'SHELL': '/bin/bash', 13:51:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vPDqDHS9qt/Listeners', 13:51:43 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 13:51:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:43 INFO - 'USER': 'cltbld', 13:51:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:43 INFO - 'XPC_FLAGS': '0x0', 13:51:43 INFO - 'XPC_SERVICE_NAME': '0', 13:51:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:43 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-8cRIUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:43 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-0d4_yL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:43 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)) 13:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:43 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-B7hrqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:44 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Dm7a6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:44 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-1d5yPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:44 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-OgddAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:44 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Noexs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:44 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-athoe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:44 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Rso121-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:44 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-iGFRTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:44 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-gLEw3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:44 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-sacg0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:45 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-6ve4uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:45 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-gA8hsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:45 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)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:45 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-_uIDPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:45 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-gRC2CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:45 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)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:45 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Ejpzi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:51:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:48 INFO - Downloading blessings-1.6.tar.gz 13:51:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:48 INFO - Installing collected packages: blessings 13:51:48 INFO - Running setup.py install for blessings 13:51:48 INFO - Successfully installed blessings 13:51:48 INFO - Cleaning up... 13:51:48 INFO - Return code: 0 13:51:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:48 INFO - Reading from file tmpfile_stdout 13:51:48 INFO - Current package versions: 13:51:48 INFO - blessings == 1.6 13:51:48 INFO - blobuploader == 1.2.4 13:51:48 INFO - docopt == 0.6.1 13:51:48 INFO - functools32 == 3.2.3-2 13:51:48 INFO - jsonschema == 2.5.1 13:51:48 INFO - manifestparser == 1.1 13:51:48 INFO - mozInstall == 1.12 13:51:48 INFO - mozcrash == 0.17 13:51:48 INFO - mozdebug == 0.1 13:51:48 INFO - mozdevice == 0.48 13:51:48 INFO - mozfile == 1.2 13:51:48 INFO - mozhttpd == 0.7 13:51:48 INFO - mozinfo == 0.9 13:51:48 INFO - mozleak == 0.1 13:51:48 INFO - mozlog == 3.4 13:51:48 INFO - moznetwork == 0.27 13:51:48 INFO - mozprocess == 0.23 13:51:48 INFO - mozprofile == 0.28 13:51:48 INFO - mozrunner == 6.12 13:51:48 INFO - mozscreenshot == 0.1 13:51:48 INFO - mozsystemmonitor == 0.3 13:51:48 INFO - moztest == 0.7 13:51:48 INFO - mozversion == 1.4 13:51:48 INFO - psutil == 3.1.1 13:51:48 INFO - requests == 1.2.3 13:51:48 INFO - wsgiref == 0.1.2 13:51:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:49 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 0x1066d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10664a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b8945cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064e8d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064e0b20>, '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.d7O0CfrPAy/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.vPDqDHS9qt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:51:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d7O0CfrPAy/Render', 13:51:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:49 INFO - 'HOME': '/Users/cltbld', 13:51:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:49 INFO - 'LOGNAME': 'cltbld', 13:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:49 INFO - 'MOZ_NO_REMOTE': '1', 13:51:49 INFO - 'NO_EM_RESTART': '1', 13:51:49 INFO - 'PAGER': '/bin/cat', 13:51:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:49 INFO - 'PWD': '/builds/slave/test', 13:51:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:49 INFO - 'SHELL': '/bin/bash', 13:51:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vPDqDHS9qt/Listeners', 13:51:49 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 13:51:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:49 INFO - 'USER': 'cltbld', 13:51:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:49 INFO - 'XPC_FLAGS': '0x0', 13:51:49 INFO - 'XPC_SERVICE_NAME': '0', 13:51:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:51:49 INFO - Cleaning up... 13:51:49 INFO - Return code: 0 13:51:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10664a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b8945cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064e8d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064e0b20>, '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.d7O0CfrPAy/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.vPDqDHS9qt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51: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', 'jsonschema'] in /builds/slave/test/build 13:51: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 jsonschema 13:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d7O0CfrPAy/Render', 13:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:50 INFO - 'HOME': '/Users/cltbld', 13:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:50 INFO - 'LOGNAME': 'cltbld', 13:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:50 INFO - 'MOZ_NO_REMOTE': '1', 13:51:50 INFO - 'NO_EM_RESTART': '1', 13:51:50 INFO - 'PAGER': '/bin/cat', 13:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:50 INFO - 'PWD': '/builds/slave/test', 13:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:50 INFO - 'SHELL': '/bin/bash', 13:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vPDqDHS9qt/Listeners', 13:51:50 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 13:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:50 INFO - 'USER': 'cltbld', 13:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:50 INFO - 'XPC_FLAGS': '0x0', 13:51:50 INFO - 'XPC_SERVICE_NAME': '0', 13:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:51:50 INFO - Cleaning up... 13:51:50 INFO - Return code: 0 13:51:50 INFO - Running post-action listener: _resource_record_post_action 13:51:50 INFO - Running post-action listener: _start_resource_monitoring 13:51:50 INFO - Starting resource monitoring. 13:51:50 INFO - [mozharness: 2016-10-26 20:51:50.471535Z] Finished create-virtualenv step (success) 13:51:50 INFO - [mozharness: 2016-10-26 20:51:50.472524Z] Running install step. 13:51:50 INFO - Running pre-action listener: _resource_record_pre_action 13:51:50 INFO - Running main action method: install 13:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:50 INFO - Reading from file tmpfile_stdout 13:51:50 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:50 INFO - Reading from file tmpfile_stdout 13:51:50 INFO - Output received: 13:51:50 INFO - Usage: mozinstall [options] installer 13:51:50 INFO - Options: 13:51:50 INFO - -h, --help show this help message and exit 13:51:50 INFO - -d DEST, --destination=DEST 13:51:50 INFO - Directory to install application into. [default: 13:51:50 INFO - "/builds/slave/test"] 13:51:50 INFO - --app=APP Application being installed. [default: firefox] 13:51:50 INFO - mkdir: /builds/slave/test/build/application 13:51:50 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'] 13:51:50 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 13:52:25 INFO - Reading from file tmpfile_stdout 13:52:25 INFO - Output received: 13:52:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:52:25 INFO - Running post-action listener: _resource_record_post_action 13:52:25 INFO - [mozharness: 2016-10-26 20:52:25.921133Z] Finished install step (success) 13:52:25 INFO - [mozharness: 2016-10-26 20:52:25.921231Z] Running run-tests step. 13:52:25 INFO - Running pre-action listener: _resource_record_pre_action 13:52:25 INFO - Running main action method: run_tests 13:52:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:52:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:52:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:52:25 INFO - 2016-10-26 13:52:25.933 screenresolution[1642:7712] starting screenresolution argv=screenresolution get 13:52:25 INFO - 2016-10-26 13:52:25.936 screenresolution[1642:7712] Display 0: 1600x1200x32@60 13:52:25 INFO - 2016-10-26 13:52:25.941 screenresolution[1643:7714] starting screenresolution argv=screenresolution list 13:52:25 INFO - Available Modes on Display 0 13:52:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:52:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:52:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:52:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:52:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:52:26 INFO - Intel Iris: 13:52:26 INFO - Chipset Model: Intel Iris 13:52:26 INFO - Type: GPU 13:52:26 INFO - Bus: Built-In 13:52:26 INFO - VRAM (Dynamic, Max): 1536 MB 13:52:26 INFO - Vendor: Intel (0x8086) 13:52:26 INFO - Device ID: 0x0a2e 13:52:26 INFO - Revision ID: 0x0009 13:52:26 INFO - Displays: 13:52:26 INFO - Display: 13:52:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:52:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:52:26 INFO - Display Serial Number: 1600x1200 60 13:52:26 INFO - Main Display: Yes 13:52:26 INFO - Mirror: Off 13:52:26 INFO - Online: Yes 13:52:26 INFO - Rotation: Supported 13:52:26 INFO - Return code: 0 13:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:52:26 INFO - Python 2.7.3 13:52:26 INFO - Return code: 0 13:52:26 INFO - grabbing minidump binary from tooltool 13:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:26 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 0x1064e8d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064e0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:52:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:52:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:52:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:52:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:52:26 INFO - Return code: 0 13:52:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:52:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:52:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:52:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:52:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0096', '--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 13:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0096 --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 13:52:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d7O0CfrPAy/Render', 13:52:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:52:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:52:26 INFO - 'HOME': '/Users/cltbld', 13:52:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:52:26 INFO - 'LOGNAME': 'cltbld', 13:52:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:52:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:26 INFO - 'MOZ_NO_REMOTE': '1', 13:52:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:52:26 INFO - 'NO_EM_RESTART': '1', 13:52:26 INFO - 'PAGER': '/bin/cat', 13:52:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:26 INFO - 'PWD': '/builds/slave/test', 13:52:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:52:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:52:26 INFO - 'SHELL': '/bin/bash', 13:52:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vPDqDHS9qt/Listeners', 13:52:26 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 13:52:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:52:26 INFO - 'USER': 'cltbld', 13:52:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:52:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:26 INFO - 'XPC_FLAGS': '0x0', 13:52:26 INFO - 'XPC_SERVICE_NAME': '0', 13:52:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:52:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0096', '--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 13:52:26 INFO - mozversion application_buildid: 20161026075526 13:52:26 INFO - mozversion application_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 13:52:26 INFO - mozversion application_display_name: Nightly 13:52:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:52:26 INFO - mozversion application_name: Firefox 13:52:26 INFO - mozversion application_remotingname: firefox 13:52:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:52:26 INFO - mozversion application_vendor: Mozilla 13:52:26 INFO - mozversion application_version: 52.0a1 13:52:26 INFO - mozversion platform_buildid: 20161026075526 13:52:26 INFO - mozversion platform_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 13:52:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:52:26 INFO - mozversion platform_version: 52.0a1 13:52:26 INFO - using testdate: 1477515146 13:52:26 INFO - actual date: 1477515146 13:52:26 INFO - starting webserver on 'localhost:49271' 13:52:26 INFO - SUITE-START | Running 2 tests 13:52:26 INFO - TEST-START | dromaeo_css 13:52:26 INFO - operating with platform_type : mac_ 13:52:26 INFO - Initialising browser for dromaeo_css test... 13:52:26 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpThghH0/profile http://localhost:49271/getInfo.html) 13:52:29 INFO - PROCESS | 1653 | 2016-10-26 13:52:29.470 plugin-container[1655:7880] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e4f, name = 'com.apple.tsm.portname' 13:52:29 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:29 INFO - PROCESS | 1653 | 2016-10-26 13:52:29.473 plugin-container[1655:7880] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9413, name = 'com.apple.CFPasteboardClient' 13:52:29 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:29 INFO - PROCESS | 1653 | 2016-10-26 13:52:29.473 plugin-container[1655:7880] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:52:29 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 13:52:29 INFO - PROCESS | 1653 | colorDepth:24 13:52:29 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 13:52:29 INFO - PROCESS | 1653 | __metrics 13:52:29 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 13:52:30 INFO - TEST-INFO | 1653: exit 0 13:52:30 INFO - Browser initialized. 13:52:30 INFO - Running cycle 1/1 for dromaeo_css test... 13:52:30 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpThghH0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:32 INFO - PROCESS | 1656 | 2016-10-26 13:52:32.720 plugin-container[1657:8005] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 13:52:32 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:32 INFO - PROCESS | 1656 | 2016-10-26 13:52:32.721 plugin-container[1657:8005] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 13:52:32 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:32 INFO - PROCESS | 1656 | 2016-10-26 13:52:32.721 plugin-container[1657:8005] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:52:42 INFO - PROCESS | 1656 | RSS: Main: 236539904 13:52:42 INFO - PROCESS | 1656 | 13:53:31 INFO - PROCESS | 1656 | 1477515211914 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] 13:55:45 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 13:55:47 INFO - PROCESS | 1656 | RSS: Main: 248922112 13:55:47 INFO - PROCESS | 1656 | 13:58:49 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 13:58:49 INFO - PROCESS | 1656 | RSS: Main: 261369856 13:58:49 INFO - PROCESS | 1656 | 14:01:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 14:01:52 INFO - PROCESS | 1656 | RSS: Main: 265859072 14:01:52 INFO - PROCESS | 1656 | 14:04:54 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 14:04:54 INFO - PROCESS | 1656 | RSS: Main: 264454144 14:04:54 INFO - PROCESS | 1656 | 14:07:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 14:07:58 INFO - PROCESS | 1656 | RSS: Main: 268795904 14:07:58 INFO - PROCESS | 1656 | 14:11:01 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 14:11:01 INFO - PROCESS | 1656 | RSS: Main: 270934016 14:11:01 INFO - PROCESS | 1656 | 14:11:01 INFO - PROCESS | 1656 | __start_tp_report 14:11:01 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 14:11:01 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 14:11:01 INFO - PROCESS | 1656 | |i|pagename|runs| 14:11:01 INFO - PROCESS | 1656 | |0;dojo.html;2937.8237305761654;3063.724264816166;3066.417380697666;3442.9139271518193;3485.041613556272;5778.24882765241;5833.795817146395;5840.328362238349;5890.58765886387;5908.852278693035;5173.818916337929;5558.944410555893;5824.417558244173;5942.524598032158;6045.063015232646;4834.274858771195;4882.438519570242;5265.921011184835;5344.545713614348;5370.758315875775;5291.576673866081;5386.111291636895;5418.187271909206;5439.102548079562;5449.4005659377435;5383.676979381211;5387.488188622075;5391.676499410029;5447.972760136194;5487.176923461493;5198.220266959948;5221.981713565856;5262.05283049051;5293.735313234323;5326.6005049621435;4309.82760689572;5248.21276808478;5290.973545132289;5295.152775555893;5319;5688.402717714622;5885.323187833411;5930.644161350289;5953.245822676506;5990.490808281302;6107.886786452548;6246.750129994794;6269.185005949197;6296.338884417116;6334.081558174039;6282.308946015934;6316.526260530432;6328.936710632881;6341.302456729756;6354.3963323484195;5976.97011514944;5983.770293360101;5984.700764961734;5999.220101386879;6002.219711437485;6130.061839218087;6290.087937249074;6302.590331628429;6419.711112999927;6424.068510066108;6190.41191086846;6225.844353891099;6267.185265915402;6272.1219029335925;6312.0531920211415;4821.590164836029;5612.494875461228;6289.937100629027;6325.493960483151;6329.525285603599;6123.83172914054;6154.230721159855;6220.626762394271;6226.470749986212;6291.087792270187;6280.591761535577;6297.086922396227;6301;6302.527310451735;6335.65153916539;5011.323471331323;5025.974870125626;5036.6726162799305;5038.395392552917;5058.418281897629;3841.5006049213425;3894.357431023849;4480.350349199413;4567.451905771262;4572.634189264851;4607.746573938465;5018.924716129261;5235.685858848481;6038.275406951107;6050.941085310141;6258.280297765815;6287.151234583364;6307.180066591313;6336.239651241881;6431.839204019843;5871.266091738533;6008.068749343859;6050.6369617823075;6079.08813677943;6101.877962440726;5446.618736688394;5473.781048758005;5485.725713714299;5516.779328826802;5582.804601838916;6421.197350331208;6451.129097571956;6452.806415807533;6474.449671777952;6610.2398224204835;6299;6331.145295385064;6337.619742815262;6348.428641422294;6350.428461438492;5383.192521121863;6179;6326.493880489642;6398.0402939559435;6399.168108145911;6235.906461402992;6290.685465726604;6324.17785687876;6329.050642403492;6330.841728956813;6233.127362169391;6284.465820405317;6309.053641953744;6320.367963203643;6346.111544383698;6133.304060594526;6136.335271946791;6140.508759299335;6206.131141640084;6242.469390101711;6210.347913469021;6242.219722534684;6283.96858015707;6299.653519056313;6301.873962520815;5350.839474815762;5812.128180772918;5972.820815375546;6036.879262414639;6176.413240742122;4972.353594032753;6155.076738489262;6227.377262273736;6307.842303942438;6311.27420346666;6147.477464415575;6177.135201071944;6184.350643182401;6202.596831205957;6208 14:11:01 INFO - PROCESS | 1656 | |1;ext.html;469.62664681578144;473.32787441832596;526.8972550352681;538.1416640458469;562.7102042448138;38322.61677383229;41209;41301.58698413023;41338;41436.17127657449;41787.164256714845;42248;42336;42386.66873321966;42462.57537424625;9465.432074075543;9649.324547281693;9666.806663866719;9682.56428460721;9709.902900971007;9488.430694158338;9555.140037396633;9557.56990935406;9585.424874507517;9612.711618651452;9570.904290957105;9602.039796020377;9606.567704453317;9608.663696770614;9657.32398732089;8080.555569443678;9503.572339244716;9594.232461403071;9623.133917947349;9635.518224088837;9431.764205894839;9457.19613832825;9490.90509094907;9559.139677428995;9596.66411675588;40343.39484907729;40388.59611403878;40496.1900761986;40653.983650408976;40789.59210407917;3290.6380298167182;3321.0626602420234;3413.1467133216697;3422.709069729076;3477.374072666919;30250;32011.03966880997;32047;32102.518462223084;32146.196345091324;2334.8132149428006;2566.538023155831;2887.321479452327;2897.8261304321595;2959.2306000439826;492810;494841;496525;497421;497885;31543.21141971469;33288.33423331568;34018.14954626154;35564.822175888956;63648;29703;35130.29739405197;35684;35727;35821;14434.350454229585;14484.203368814817;14611.634709132144;14621;14640.19478928648;12179.695507612381;12262.325572093441;12273.877261227452;12303.93848030754;12373.381330933596;7696.846063078707;7752.728654497066;7789.12277549877;7790;7808.5314881107315;2771.3071732066983;3268.2319654881085;3277.213468767526;3283.1463819407127;3295.9011229663147;896.2740180453853;950.5437390052675;988.9764094162507;1026.6602084279937;1029.505837198149;26806.5979010315;29813.850930745208;30360;31013;31360.68639313623;893.5576889439639;959.9009134540912;994.9900850636465;1061.7823346214007;1087.5921529426464;14842.332095055748;15512.767308490382;16138.273777680033;16200.837991620168;16201.270942807367;651578;651874;652130;658407;658637;59246;59346;59352;59699.701501492214;59763;1334.8665133486575;1372.3412761874156;1377.2081053394338;1395.6929475515167;1401.1242973141786;22590.09639614397;26600.201993940213;27234.455310893274;30435.391292174474;30503.389932201677;52437;55076.449235508735;56534;56702.14946775719;60212.69893650504;537246;540242;546582.267088662;547028.0323369274;547247;34420.96737097891;41601.37597936094;43242;43313.350299744896;43381;37278;43175.784121079196;43391.78304108459;46281.768591156826;47265;38694.419583705705;38846.4173037399;39141.608583913796;39852.402213966234;39905;38406.23187536289;38729.4190587147;38862;39618.60381396149;40779.776606701846;33322.83338583291;34255;36802.07994800151;39081.80459097686;39328.82013539598;34502.30995380128;35220.47169292411;35539.82230088833;35561;35988.4601730969;22489;24060.278191654277;24167.75832241655;25954;26486.470270594866 14:11:01 INFO - PROCESS | 1656 | |2;jquery.html;303.59015329305424;375.56246972277296;376.12738446803417;381.0568842115764;403.4956304619226;18930.33743818965;19445.513862153453;19951.700724489143;20626.071826767795;20890.791092089075;15633.296501657424;15978.600534986632;18034.09829508526;18631.441056768286;20220.494487637818;4865.635077369203;5431.945680543204;6136.846578835521;6168.814935551918;6178.258608966908;5695.401982791809;6015.578909476339;6064.4541991220785;6074.119252708355;6084.847878803021;5775.480206781389;5944.702764861761;6041.124037014631;6044.546659000571;6060.181875446824;5922.674252916088;6045.758169673208;6053.848653783647;6058.606190597597;6066.393360663942;5222.373315202162;5224.686518808883;5229.947700522984;5253.3170687810725;5529.142982837667;11749.765004699859;12007.93996030023;12052.096092793076;12217.816732749016;12294.569690060805;2198.8240940724704;2290.4633615333464;2291.7364503082194;2445.6576079348906;2874.9937521867387;9804.90195098047;10132.848007279898;14688;14990.925045374703;15353.07881527112;1831.835134837871;1843.4930394141584;1866.5426970392205;1872.5318670332417;1897.0988780329371;106865;115741;117211;118071.4096429521;118507;10282;10687.038166564891;11524.078073754079;11581.478833452515;11623.53505859773;14339.426422943174;14359.282035898163;14413.42346306157;14431;14436;8298.668053277923;8436;8457.238848503664;8460.619272132768;8579.485230886166;8313.958430207811;8324.25081742646;8334.708285209988;8451.1548845115;8487.660493580188;4463.754493502824;4553.453585569753;4569.977150114228;4570.131674981742;4604.746738929324;1911.3883557261543;1959.9902000490192;1981.6730239510318;1988.9701654475195;2013.6274789163758;770.5299767142039;848.1687945813138;881.7046289492963;898.9056149104381;984.6209209454412;20297.086631101636;20868.373948781562;21246;21343.46641333948;22572.66141007886;855.2644725536034;960.2845879819439;960.4237457525429;962.4936973636237;976.1068622210598;10439.164866810637;10710.536576587428;10882.727931801768;10894.074003709773;10973.396463194442;463575;466496;471539;568962;618861;123553.76446235423;127623;127784.99999999814;129426;131419;1006.718118926687;1045.2369770067894;1091.0017334139332;1093.8413929980109;1097.4841824342545;15881.444149454714;18676.906615466836;18896.811031889505;19589.902050489658;19640.312589059315;53001.879924802575;54905;55214;55861.441385585626;56367.71816140893;55940.16089758575;65280.020799687096;77654.2234577647;78050.2194978043;82641;5959.28488581373;6427.42153206195;6949.478789090737;7962.522248665098;8261.710840120568;8927.866082008644;9232.030636783042;10483.266171367932;11476.713082172679;12932.41804118798;8247.505149691038;9531.237501000041;11082.778344433227;11650.6504804856;11700.133467300566;10859.674209773719;11160.888391115985;11231.55073797039;11510.48202830858;11689.123315751523;9550.570224340061;11338.60314888975;11586.652400428;11808.7600801918;11941.701457463632;7882.605869706606;7960.049787802026;8046.718364857202;8447.831043379221;8459.61931713062;8258.628361723857;10250.436226007641;11404.771904561696;11615.477303521193;11627.6511704649 14:11:01 INFO - PROCESS | 1656 | |3;mootools.html;1435.9066660667058;1543.3209387869338;1659.6929568029907;1759.9912000439997;1856.0997916010733;7809.960950195241;8082.95958520208;8361.163883611636;8774.078721734213;8825.16160964708;8304.543250121242;8598.269147122503;8617.310615150789;8720.8691869622;8763.780905477366;2330.021391015773;2346.3899386159637;2354.682117914077;2356.71719393673;2364.988175059122;2355.5642206191824;2379.8334116611845;2406.3984003999;2408.4580969281947;2418.697662792151;2346.8239882008834;2347.438953096189;2350.553394854972;2374.7031621047367;2378.6669866218745;2037.9694304585369;2329.6738456616085;2341.0518739910362;2345.1088586337255;2346.0381243690003;1948.3765195137562;2364.5625559271416;2373.133806160739;2373.394784330002;2379.619260918245;8543.700970466067;8590.398672092893;8701.216890479887;8711.172438618385;8731.912680873236;5142.305788718512;5266.473352664703;5405.702686352249;5406.189071639246;5409.648372855791;3326.534285200074;3508.19311558343;3604.495370648085;3635.272945410902;3644;952.4142652268874;1024.08856118055;1028.3213079367656;1069.5775168808354;1077.3159044007034;11292.378919159442;11339.603113890975;11407;11419.714507137305;11461.255018423775;4262.318029115327;4682.6253899687945;4747.620190384761;4822.42130944289;4851.611871050308;9723.659671911591;9746.853797193047;9786.266030047775;9789.804203915883;9801.11789938909;5313.548348390353;5327.520523152934;5353.330833645794;5358.5981051421295;5365.436629153961;4357.368181613649;4412.3160910059;4836.395450568679;4854.247591623304;4861.95138048615;3814.561325447609;3867.994321476436;3935.665468435158;3943.3690609502914;3965.6034396560112;1103.266327891959;1277.881853378294;1281.6347341007954;1297.863724308953;1302.2902518127644;843.1020962674731;899.2176806178536;916.3127654259306;917.6100157433198;933.9346245762731;5829.446202610745;5926.377730338339;5989.341172471112;6030.48740857032;6104.560002787499;419.5741322557607;425.97231179973824;429.3066697283864;432.19611522568624;443.57416879795113;3247.886323978649;3945.4279129526058;4041.7170798043853;4050.513938327361;4066.3087275163293;10162.695119146438;10340.534675939602;10514.421706806046;10530.15758739299;10550;10461.372317660966;10467.790644187073;10481.947590262;10490;10496.632617858491;7104.450861296405;7871;8171.591420428955;8207.138250483733;8246.463979841412;4404.691671582958;5035;5799.246098007232;5876;5918.644881307136;9455.621775129193;9581;9642.71071867845;9699.078587534173;9716.125548700367;9712.9028709712;9745.535448242916;9766.609335626496;9866.210703143588;9889.208863291064;7323.8535229296185;7366.77899663011;7389.704411823467;7408.333250007525;7412.274806728235;7928.722494712657;7947.165547617417;7979.5611241382285;8025.23760242776;8060.717874874351;7203.387712044535;7393.55638661682;7395.260473952561;7519.962400187964;7573.621318933921;7144.106986626672;7322.96338518304;7328;7332.706691732271;7361.006264154271;6790.219124800711;6907.827304317432;6958.756443524452;6965.895511567432;6982.615956122462;4871.269309603588;5037.92443113361;5038.269450929668;5051.974740126423;5105.821296254613;4937.136001199848;4960.082384758831;5068.82259120929;5093.643444958965;5099.796008159632 14:11:01 INFO - PROCESS | 1656 | |4;prototype.html;295.29130087789304;302.4510513418147;303.3750474023512;314.33204440563804;315.3094722557597;4646.930296045562;5388.218708287296;5707.971460142699;5773.3649298577175;5796.797112101077;4668.206404911165;4859.611231101503;5308.867278318044;5411.323584551931;5535.944640553594;3676.669099781019;3893.279743247508;4155.563665815092;4272.636825869805;4288.807003684826;3332.6500717424683;4017.37730651748;4278.2940814765525;4315.892102697442;4317.956820431787;3470.4620783778555;3649.7262705297076;4157.334826427772;4158.6465150462245;4177.582241775828;3835.8875925981433;3860.297791545901;4168.082342360345;4179.26560477403;4181.682769927494;3372.8988130355883;3597.3704601694863;3631.8547258109643;3636.6363363663686;3639.6906262967677;4226;4431.7119387240045;5044.629024358545;5439.88482361115;5568.220449137124;3831.597682243352;4188.81150348235;4840.975795121037;4855.781489832931;4869.440014398318;4968.677035992649;5990.670513121777;5992.670403127826;6016.578839481238;6045.52133625216;3848.730588858781;3984.880453586397;3985;3989.7207195496326;4009.659178969791;6208;6256.2492500899725;6260.593061450991;6264.3422440643535;6323.9447179666795;3263.7225835804225;3575.3385623659706;3865.3379047009494;4047.3321901886447;4050.5139383274195;3433.4678124890183;3456.8617255309505;3930.678576602766;4047.2680940365726;4085.958080689405;3993.381025940984;4046.7976601169826;4683.180443422388;4805.303231031551;4845.927311090337;5714.200011998323;5751.827445176651;5872.882542349129;5983.563944653252;6072.666003369769;1188.6018183908316;1256.7360854220533;1275.0309764578801;1320.19468124444;1383.89620778442;891.643342662927;896.4666023715879;906.6128822900972;909.8990221831658;945.5697657565792;4728.598069164091;5580.748866301026;5615.747291371898;5665.526962989652;5672.773089076473;5633.690147041952;6086.9391306087255;6166.537509686791;6176.598521096114;6184.8971349741305;4634.6987445816585;4943.555080042814;5101.540861322499;5104.591632669378;5644.774209031675;2328.767123287658;2496.463260399023;2626.159628918766;2754.380264440485;2763.2401089700493;4626.298960831322;5219.0074592936435;5255.500727430888;5263.763130659129;5315.6279060465395;4889.257420302301;4920.941997470561;4985.027919555652;5021.096202683552;5195.480451954774;4583.587477127075;4879.706877677419;5043.470435604208;5078.898422031612;5345.812896548602;4590.416306374295;5172;5183.222516622537;5186.974065129651;5207.843764687065;4427.005331576166;4588.715159755274;5085.982803439401;5128.79484820603;5176.178982454647;4968.552830245295;5085.7711402986215;5297.602679798953;5325.363944847325;5386.9529578761385;3259.755518336087;3416.4704470807064;3481.791092534456;3538.8413068027967;3563.6436356365193;3782.659560639556;5074.289599456005;5169.578365949394;5926.111083337361;6144.743286058396;5848.718999590078;5911.586188966731;6039.758409663565;6046.758129674764;6048.758049677964;6047.425494578008;6055.9091613626715;6084.209052823105;6085.4523092921845;6134.693265336805;5477.424870388551;5549;5809.448102430262;5896.292444906639;5953.600903787693;4852.44196917359;5253.395859476209;5922.644641321534;6028.367021462858;6050.183225264709;4636.536346365337;4826.855194344175;4870.421803504694;5243.973780131075;5801.36185019639 14:11:01 INFO - PROCESS | 1656 | |5;yui.html;718.2637796258838;722.4112348436024;772.5287574579509;772.7797577690355;852.075498084578;14479.638009049779;15317.84682153178;15380.846191538096;15396.769048464254;15450.922745386271;14061.929690351533;14201.017786264896;14221.928890355559;14245.78631320531;14300.284985750697;690.4200471603851;712.6686090967698;860.371928492201;874.3180319350901;877.0659247900996;745.6868115391549;856.3791251342789;885.4510203673731;885.8405487012335;887.0154128916897;909.222614664459;911.1890417528405;915.4004127296631;943.8820147481565;944.574941276425;893.8167675626481;914.090479972425;921.5346250143668;939.5255396025032;939.9859002114973;669.036587314266;675.0650349266252;678.2064983968719;688.5180373738403;696.0012382231463;14369.640758981004;14571.19858407787;14674.486392976301;14713.337899794427;15035.54893353201;13922.791158132635;13955.860441395558;14011.929940350234;14093.859061409357;14502.85497145036;11333.659990200225;11456;11537.884621153766;11594.826077608843;11645.70885727855;3740.195857890539;3744.4944932434046;3871.2451072040963;3901.6683581895572;3935.822887970048;75778.62110689466;78522.60738696327;78541.21458785396;84685.57657211737;85267.72098418529;10775.137988960865;10900.890991090146;10902.18233632465;10911.618093366695;11089.112870970303;16904.746428803577;20766;20940.58118837615;20994;21045.789542104383;7849.686012559548;7936.4047696423;8038.954935858301;8153.103158652543;8200.712975045964;4355.1507456045765;4365.6234377552455;4395.362672412546;4421.115776844644;4525.570070843265;3442.5524681791208;3537.699295559855;3557.181848174934;3557.1996300832625;3560.732945029133;607.908813677943;652.6997581112646;657.8486948001986;668.8762578922915;685.7497013590004;590.3565114025647;607.3986753114385;653.4249860123156;665.5906617430343;674.6626686656672;9035.63857445708;9071.501067441222;9074.183323500916;9219.492927888896;9443.858342124873;559.0725155780592;614.8555089553952;625.4941055384504;629.7418058595954;693.6427739714052;3577.874774382884;4050.23045621331;4134.64855487287;4268.957310426856;4329.134173165379;83234.58382708169;107866.46066769616;114153;115042;115220;72697;79146;80592.59703701444;99040.50479747556;100332;68382.65808671025;87001.5649921759;88570;89500.6574901377;92144.53927730318;8629.303117046758;8768.342374321825;8775.56122193875;8792.120787921156;8879.378443508893;40944;43324.56675433205;48983.26525102055;52982.94034119219;57243.42756572381;72347.55304893978;72940.63529682318;74858.51414858471;75391;76244.61877690576;12490.313032783284;12652.936735316265;12734;12864.871351286742;12941;14106.647333816736;14141.717165656835;14193.574192774233;14284.857151428352;14387.496437624633;12984.610461686165;13059.34703264852;13187.73624527485;13661.453541858215;13737.381817818023;12930.676733081747;13261.66845828862;13302;13621.659458513617;13812.309384530532;12598.244105353708;12968.675783105498;12974.740505190031;13443.193408395136;13546.661333466742;10021.656928482786;10449.268551201647;11207.66377008691;11237.66588544397;11314.886851131383;10436.112930401001;10928;11146.386948717898;11205.551777929119;11210.83183752228 14:11:01 INFO - PROCESS | 1656 | __end_tp_report 14:11:01 INFO - PROCESS | 1656 | __start_cc_report 14:11:01 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,361 14:11:01 INFO - PROCESS | 1656 | __end_cc_report 14:11:01 INFO - PROCESS | 1656 | __startTimestamp1477516261597__endTimestamp 14:11:01 INFO - PROCESS | 1656 | 14:11:01 INFO - PROCESS | 1656 | ------- Summary: start ------- 14:11:01 INFO - PROCESS | 1656 | Number of tests: 6 14:11:01 INFO - PROCESS | 1656 | 14:11:01 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5789.57 Median:6101.88 stddev:716.54 (11.7%) stddev-sans-first:682.93 14:11:01 INFO - PROCESS | 1656 | Values: 2937.8 3063.7 3066.4 3442.9 3485.0 5778.2 5833.8 5840.3 5890.6 5908.9 5173.8 5558.9 5824.4 5942.5 6045.1 4834.3 4882.4 5265.9 5344.5 5370.8 5291.6 5386.1 5418.2 5439.1 5449.4 5383.7 5387.5 5391.7 5448.0 5487.2 5198.2 5222.0 5262.1 5293.7 5326.6 4309.8 5248.2 5291.0 5295.2 5319.0 5688.4 5885.3 5930.6 5953.2 5990.5 6107.9 6246.8 6269.2 6296.3 6334.1 6282.3 6316.5 6328.9 6341.3 6354.4 5977.0 5983.8 5984.7 5999.2 6002.2 6130.1 6290.1 6302.6 6419.7 6424.1 6190.4 6225.8 6267.2 6272.1 6312.1 4821.6 5612.5 6289.9 6325.5 6329.5 6123.8 6154.2 6220.6 6226.5 6291.1 6280.6 6297.1 6301.0 6302.5 6335.7 5011.3 5026.0 5036.7 5038.4 5058.4 3841.5 3894.4 4480.4 4567.5 4572.6 4607.7 5018.9 5235.7 6038.3 6050.9 6258.3 6287.2 6307.2 6336.2 6431.8 5871.3 6008.1 6050.6 6079.1 6101.9 5446.6 5473.8 5485.7 5516.8 5582.8 6421.2 6451.1 6452.8 6474.4 6610.2 6299.0 6331.1 6337.6 6348.4 6350.4 5383.2 6179.0 6326.5 6398.0 6399.2 6235.9 6290.7 6324.2 6329.1 6330.8 6233.1 6284.5 6309.1 6320.4 6346.1 6133.3 6136.3 6140.5 6206.1 6242.5 6210.3 6242.2 6284.0 6299.7 6301.9 5350.8 5812.1 5972.8 6036.9 6176.4 4972.4 6155.1 6227.4 6307.8 6311.3 6147.5 6177.1 6184.4 6202.6 6208.0 14:11:01 INFO - PROCESS | 1656 | 14:11:01 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:68535.49 Median:40366.00 stddev:152194.95 (377.0%) stddev-sans-first:152536.10 14:11:01 INFO - PROCESS | 1656 | Values: 469.6 473.3 526.9 538.1 562.7 38322.6 41209.0 41301.6 41338.0 41436.2 41787.2 42248.0 42336.0 42386.7 42462.6 9465.4 9649.3 9666.8 9682.6 9709.9 9488.4 9555.1 9557.6 9585.4 9612.7 9570.9 9602.0 9606.6 9608.7 9657.3 8080.6 9503.6 9594.2 9623.1 9635.5 9431.8 9457.2 9490.9 9559.1 9596.7 40343.4 40388.6 40496.2 40654.0 40789.6 3290.6 3321.1 3413.1 3422.7 3477.4 30250.0 32011.0 32047.0 32102.5 32146.2 2334.8 2566.5 2887.3 2897.8 2959.2 492810.0 494841.0 496525.0 497421.0 497885.0 31543.2 33288.3 34018.1 35564.8 63648.0 29703.0 35130.3 35684.0 35727.0 35821.0 14434.4 14484.2 14611.6 14621.0 14640.2 12179.7 12262.3 12273.9 12303.9 12373.4 7696.8 7752.7 7789.1 7790.0 7808.5 2771.3 3268.2 3277.2 3283.1 3295.9 896.3 950.5 989.0 1026.7 1029.5 26806.6 29813.9 30360.0 31013.0 31360.7 893.6 959.9 995.0 1061.8 1087.6 14842.3 15512.8 16138.3 16200.8 16201.3 651578.0 651874.0 652130.0 658407.0 658637.0 59246.0 59346.0 59352.0 59699.7 59763.0 1334.9 1372.3 1377.2 1395.7 1401.1 22590.1 26600.2 27234.5 30435.4 30503.4 52437.0 55076.4 56534.0 56702.1 60212.7 537246.0 540242.0 546582.3 547028.0 547247.0 34421.0 41601.4 43242.0 43313.4 43381.0 37278.0 43175.8 43391.8 46281.8 47265.0 38694.4 38846.4 39141.6 39852.4 39905.0 38406.2 38729.4 38862.0 39618.6 40779.8 33322.8 34255.0 36802.1 39081.8 39328.8 34502.3 35220.5 35539.8 35561.0 35988.5 22489.0 24060.3 24167.8 25954.0 26486.5 14:11:01 INFO - PROCESS | 1656 | 14:11:01 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:32121.49 Median:2368.70 stddev:87884.06 (3710.2%) stddev-sans-first:88098.13 14:11:01 INFO - PROCESS | 1656 | Values: 303.6 375.6 376.1 381.1 403.5 18930.3 19445.5 19951.7 20626.1 20890.8 15633.3 15978.6 18034.1 18631.4 20220.5 4865.6 5431.9 6136.8 6168.8 6178.3 5695.4 6015.6 6064.5 6074.1 6084.8 5775.5 5944.7 6041.1 6044.5 6060.2 5922.7 6045.8 6053.8 6058.6 6066.4 5222.4 5224.7 5229.9 5253.3 5529.1 11749.8 12007.9 12052.1 12217.8 12294.6 2198.8 2290.5 2291.7 2445.7 2875.0 9804.9 10132.8 14688.0 14990.9 15353.1 1831.8 1843.5 1866.5 1872.5 1897.1 106865.0 115741.0 117211.0 118071.4 118507.0 10282.0 10687.0 11524.1 11581.5 11623.5 14339.4 14359.3 14413.4 14431.0 14436.0 8298.7 8436.0 8457.2 8460.6 8579.5 8314.0 8324.3 8334.7 8451.2 8487.7 4463.8 4553.5 4570.0 4570.1 4604.7 1911.4 1960.0 1981.7 1989.0 2013.6 770.5 848.2 881.7 898.9 984.6 20297.1 20868.4 21246.0 21343.5 22572.7 855.3 960.3 960.4 962.5 976.1 10439.2 10710.5 10882.7 10894.1 10973.4 463575.0 466496.0 471539.0 568962.0 618861.0 123553.8 127623.0 127785.0 129426.0 131419.0 1006.7 1045.2 1091.0 1093.8 1097.5 15881.4 18676.9 18896.8 19589.9 19640.3 53001.9 54905.0 55214.0 55861.4 56367.7 55940.2 65280.0 77654.2 78050.2 82641.0 5959.3 6427.4 6949.5 7962.5 8261.7 8927.9 9232.0 10483.3 11476.7 12932.4 8247.5 9531.2 11082.8 11650.7 11700.1 10859.7 11160.9 11231.6 11510.5 11689.1 9550.6 11338.6 11586.7 11808.8 11941.7 7882.6 7960.0 8046.7 8447.8 8459.6 8258.6 10250.4 11404.8 11615.5 11627.7 14:11:01 INFO - PROCESS | 1656 | 14:11:01 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5603.34 Median:5045.12 stddev:3132.40 (62.1%) stddev-sans-first:3125.53 14:11:01 INFO - PROCESS | 1656 | Values: 1435.9 1543.3 1659.7 1760.0 1856.1 7810.0 8083.0 8361.2 8774.1 8825.2 8304.5 8598.3 8617.3 8720.9 8763.8 2330.0 2346.4 2354.7 2356.7 2365.0 2355.6 2379.8 2406.4 2408.5 2418.7 2346.8 2347.4 2350.6 2374.7 2378.7 2038.0 2329.7 2341.1 2345.1 2346.0 1948.4 2364.6 2373.1 2373.4 2379.6 8543.7 8590.4 8701.2 8711.2 8731.9 5142.3 5266.5 5405.7 5406.2 5409.6 3326.5 3508.2 3604.5 3635.3 3644.0 952.4 1024.1 1028.3 1069.6 1077.3 11292.4 11339.6 11407.0 11419.7 11461.3 4262.3 4682.6 4747.6 4822.4 4851.6 9723.7 9746.9 9786.3 9789.8 9801.1 5313.5 5327.5 5353.3 5358.6 5365.4 4357.4 4412.3 4836.4 4854.2 4862.0 3814.6 3868.0 3935.7 3943.4 3965.6 1103.3 1277.9 1281.6 1297.9 1302.3 843.1 899.2 916.3 917.6 933.9 5829.4 5926.4 5989.3 6030.5 6104.6 419.6 426.0 429.3 432.2 443.6 3247.9 3945.4 4041.7 4050.5 4066.3 10162.7 10340.5 10514.4 10530.2 10550.0 10461.4 10467.8 10481.9 10490.0 10496.6 7104.5 7871.0 8171.6 8207.1 8246.5 4404.7 5035.0 5799.2 5876.0 5918.6 9455.6 9581.0 9642.7 9699.1 9716.1 9712.9 9745.5 9766.6 9866.2 9889.2 7323.9 7366.8 7389.7 7408.3 7412.3 7928.7 7947.2 7979.6 8025.2 8060.7 7203.4 7393.6 7395.3 7520.0 7573.6 7144.1 7323.0 7328.0 7332.7 7361.0 6790.2 6907.8 6958.8 6965.9 6982.6 4871.3 5037.9 5038.3 5052.0 5105.8 4937.1 4960.1 5068.8 5093.6 5099.8 14:11:01 INFO - PROCESS | 1656 | 14:11:01 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4522.31 Median:4956.05 stddev:1439.22 (29.0%) stddev-sans-first:1407.85 14:11:01 INFO - PROCESS | 1656 | Values: 295.3 302.5 303.4 314.3 315.3 4646.9 5388.2 5708.0 5773.4 5796.8 4668.2 4859.6 5308.9 5411.3 5535.9 3676.7 3893.3 4155.6 4272.6 4288.8 3332.7 4017.4 4278.3 4315.9 4318.0 3470.5 3649.7 4157.3 4158.6 4177.6 3835.9 3860.3 4168.1 4179.3 4181.7 3372.9 3597.4 3631.9 3636.6 3639.7 4226.0 4431.7 5044.6 5439.9 5568.2 3831.6 4188.8 4841.0 4855.8 4869.4 4968.7 5990.7 5992.7 6016.6 6045.5 3848.7 3984.9 3985.0 3989.7 4009.7 6208.0 6256.2 6260.6 6264.3 6323.9 3263.7 3575.3 3865.3 4047.3 4050.5 3433.5 3456.9 3930.7 4047.3 4086.0 3993.4 4046.8 4683.2 4805.3 4845.9 5714.2 5751.8 5872.9 5983.6 6072.7 1188.6 1256.7 1275.0 1320.2 1383.9 891.6 896.5 906.6 909.9 945.6 4728.6 5580.7 5615.7 5665.5 5672.8 5633.7 6086.9 6166.5 6176.6 6184.9 4634.7 4943.6 5101.5 5104.6 5644.8 2328.8 2496.5 2626.2 2754.4 2763.2 4626.3 5219.0 5255.5 5263.8 5315.6 4889.3 4920.9 4985.0 5021.1 5195.5 4583.6 4879.7 5043.5 5078.9 5345.8 4590.4 5172.0 5183.2 5187.0 5207.8 4427.0 4588.7 5086.0 5128.8 5176.2 4968.6 5085.8 5297.6 5325.4 5387.0 3259.8 3416.5 3481.8 3538.8 3563.6 3782.7 5074.3 5169.6 5926.1 6144.7 5848.7 5911.6 6039.8 6046.8 6048.8 6047.4 6055.9 6084.2 6085.5 6134.7 5477.4 5549.0 5809.4 5896.3 5953.6 4852.4 5253.4 5922.6 6028.4 6050.2 4636.5 4826.9 4870.4 5244.0 5801.4 14:11:01 INFO - PROCESS | 1656 | 14:11:01 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:20006.74 Median:23826.85 stddev:28700.33 (120.5%) stddev-sans-first:28744.30 14:11:01 INFO - PROCESS | 1656 | Values: 718.3 722.4 772.5 772.8 852.1 14479.6 15317.8 15380.8 15396.8 15450.9 14061.9 14201.0 14221.9 14245.8 14300.3 690.4 712.7 860.4 874.3 877.1 745.7 856.4 885.5 885.8 887.0 909.2 911.2 915.4 943.9 944.6 893.8 914.1 921.5 939.5 940.0 669.0 675.1 678.2 688.5 696.0 14369.6 14571.2 14674.5 14713.3 15035.5 13922.8 13955.9 14011.9 14093.9 14502.9 11333.7 11456.0 11537.9 11594.8 11645.7 3740.2 3744.5 3871.2 3901.7 3935.8 75778.6 78522.6 78541.2 84685.6 85267.7 10775.1 10900.9 10902.2 10911.6 11089.1 16904.7 20766.0 20940.6 20994.0 21045.8 7849.7 7936.4 8039.0 8153.1 8200.7 4355.2 4365.6 4395.4 4421.1 4525.6 3442.6 3537.7 3557.2 3557.2 3560.7 607.9 652.7 657.8 668.9 685.7 590.4 607.4 653.4 665.6 674.7 9035.6 9071.5 9074.2 9219.5 9443.9 559.1 614.9 625.5 629.7 693.6 3577.9 4050.2 4134.6 4269.0 4329.1 83234.6 107866.5 114153.0 115042.0 115220.0 72697.0 79146.0 80592.6 99040.5 100332.0 68382.7 87001.6 88570.0 89500.7 92144.5 8629.3 8768.3 8775.6 8792.1 8879.4 40944.0 43324.6 48983.3 52982.9 57243.4 72347.6 72940.6 74858.5 75391.0 76244.6 12490.3 12652.9 12734.0 12864.9 12941.0 14106.6 14141.7 14193.6 14284.9 14387.5 12984.6 13059.3 13187.7 13661.5 13737.4 12930.7 13261.7 13302.0 13621.7 13812.3 12598.2 12968.7 12974.7 13443.2 13546.7 10021.7 10449.3 11207.7 11237.7 11314.9 10436.1 10928.0 11146.4 11205.6 11210.8 14:11:01 INFO - PROCESS | 1656 | -------- Summary: end -------- 14:11:01 INFO - PROCESS | 1656 | 14:11:02 INFO - TEST-INFO | 1656: exit 0 14:11:02 INFO - TEST-OK | dromaeo_css | took 1115823ms 14:11:02 INFO - TEST-START | kraken 14:11:02 INFO - operating with platform_type : mac_ 14:11:02 INFO - Initialising browser for kraken test... 14:11:02 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmplrf3Hb/profile http://localhost:49271/getInfo.html) 14:11:05 INFO - PROCESS | 1668 | 2016-10-26 14:11:05.213 plugin-container[1669:10379] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 14:11:05 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:11:05 INFO - PROCESS | 1668 | 2016-10-26 14:11:05.216 plugin-container[1669:10379] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 14:11:05 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:11:05 INFO - PROCESS | 1668 | 2016-10-26 14:11:05.216 plugin-container[1669:10379] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:11:05 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 14:11:05 INFO - PROCESS | 1668 | colorDepth:24 14:11:05 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 14:11:05 INFO - PROCESS | 1668 | __metrics 14:11:05 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 14:11:06 INFO - TEST-INFO | 1668: exit 0 14:11:06 INFO - Browser initialized. 14:11:06 INFO - Running cycle 1/1 for kraken test... 14:11:06 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmplrf3Hb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:08 INFO - PROCESS | 1670 | 2016-10-26 14:11:08.633 plugin-container[1671:10507] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x874b, name = 'com.apple.tsm.portname' 14:11:08 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:11:08 INFO - PROCESS | 1670 | 2016-10-26 14:11:08.634 plugin-container[1671:10507] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e17, name = 'com.apple.CFPasteboardClient' 14:11:08 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:11:08 INFO - PROCESS | 1670 | 2016-10-26 14:11:08.634 plugin-container[1671:10507] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:11:18 INFO - PROCESS | 1670 | RSS: Main: 236777472 14:11:18 INFO - PROCESS | 1670 | 14:11:21 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 14:11:22 INFO - PROCESS | 1670 | RSS: Main: 249389056 14:11:22 INFO - PROCESS | 1670 | 14:11:25 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 14:11:25 INFO - PROCESS | 1670 | RSS: Main: 256978944 14:11:25 INFO - PROCESS | 1670 | 14:11:28 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 14:11:29 INFO - PROCESS | 1670 | RSS: Main: 259801088 14:11:29 INFO - PROCESS | 1670 | 14:11:31 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 14:11:32 INFO - PROCESS | 1670 | RSS: Main: 260845568 14:11:32 INFO - PROCESS | 1670 | 14:11:34 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:11:34 INFO - PROCESS | 1670 | RSS: Main: 262557696 14:11:34 INFO - PROCESS | 1670 | 14:11:37 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 14:11:38 INFO - PROCESS | 1670 | RSS: Main: 263487488 14:11:38 INFO - PROCESS | 1670 | 14:11:41 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 14:11:41 INFO - PROCESS | 1670 | RSS: Main: 263811072 14:11:41 INFO - PROCESS | 1670 | 14:11:44 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 14:11:45 INFO - PROCESS | 1670 | RSS: Main: 264040448 14:11:45 INFO - PROCESS | 1670 | 14:11:46 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:11:47 INFO - PROCESS | 1670 | RSS: Main: 263569408 14:11:47 INFO - PROCESS | 1670 | 14:11:49 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:11:50 INFO - PROCESS | 1670 | RSS: Main: 263684096 14:11:50 INFO - PROCESS | 1670 | 14:11:52 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:11:53 INFO - PROCESS | 1670 | RSS: Main: 263753728 14:11:53 INFO - PROCESS | 1670 | 14:11:56 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:11:57 INFO - PROCESS | 1670 | RSS: Main: 264134656 14:11:57 INFO - PROCESS | 1670 | 14:12:00 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:12:00 INFO - PROCESS | 1670 | RSS: Main: 264122368 14:12:00 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 14:12:02 INFO - PROCESS | 1670 | RSS: Main: 265461760 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | __start_tp_report 14:12:02 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 14:12:02 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 14:12:02 INFO - PROCESS | 1670 | |i|pagename|runs| 14:12:02 INFO - PROCESS | 1670 | |0;ai-astar;105;116;116;118;116;117;120;118;116;119 14:12:02 INFO - PROCESS | 1670 | |1;audio-beat-detection;151;123;146;164;141;147;141;146;142;113 14:12:02 INFO - PROCESS | 1670 | |2;audio-dft;204;190;206;275;198;187;195;199;194;194 14:12:02 INFO - PROCESS | 1670 | |3;audio-fft;84;59;58;82;62;60;69;60;80;59 14:12:02 INFO - PROCESS | 1670 | |4;audio-oscillator;84;71;87;72;68;70;86;68;71;89 14:12:02 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;93;76;135;132;92;98;136;112;92;103 14:12:02 INFO - PROCESS | 1670 | |6;imaging-darkroom;97;97;117;120;97;95;98;97;105;141 14:12:02 INFO - PROCESS | 1670 | |7;imaging-desaturate;88;90;93;84;136;139;91;91;87;88 14:12:02 INFO - PROCESS | 1670 | |8;json-parse-financial;55;55;58;57;58;59;58;56;57;59 14:12:02 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;68;74;71;73;89;107;103;104;100;71 14:12:02 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;87;90;90;86;87;89;80;101;111;78 14:12:02 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;145;137;153;159;158;146;152;161;212;195 14:12:02 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;173;172;175;169;238;244;187;177;177;183 14:12:02 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;69;72;73;70;70;71;70;69;78;91 14:12:02 INFO - PROCESS | 1670 | __end_tp_report 14:12:02 INFO - PROCESS | 1670 | __start_cc_report 14:12:02 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,956 14:12:02 INFO - PROCESS | 1670 | __end_cc_report 14:12:02 INFO - PROCESS | 1670 | __startTimestamp1477516322702__endTimestamp 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | ------- Summary: start ------- 14:12:02 INFO - PROCESS | 1670 | Number of tests: 14 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:116.10 Median:117.50 stddev:4.15 (3.5%) stddev-sans-first:1.50 14:12:02 INFO - PROCESS | 1670 | Values: 105.0 116.0 116.0 118.0 116.0 117.0 120.0 118.0 116.0 119.0 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:146.00 stddev:14.23 (9.7%) stddev-sans-first:14.66 14:12:02 INFO - PROCESS | 1670 | Values: 151.0 123.0 146.0 164.0 141.0 147.0 141.0 146.0 142.0 113.0 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:204.20 Median:198.50 stddev:25.54 (12.9%) stddev-sans-first:27.09 14:12:02 INFO - PROCESS | 1670 | Values: 204.0 190.0 206.0 275.0 198.0 187.0 195.0 199.0 194.0 194.0 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:67.30 Median:65.50 stddev:10.64 (16.2%) stddev-sans-first:9.41 14:12:02 INFO - PROCESS | 1670 | Values: 84.0 59.0 58.0 82.0 62.0 60.0 69.0 60.0 80.0 59.0 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:78.00 stddev:8.69 (11.1%) stddev-sans-first:8.80 14:12:02 INFO - PROCESS | 1670 | Values: 84.0 71.0 87.0 72.0 68.0 70.0 86.0 68.0 71.0 89.0 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:106.90 Median:84.00 stddev:21.03 (25.0%) stddev-sans-first:21.69 14:12:02 INFO - PROCESS | 1670 | Values: 93.0 76.0 135.0 132.0 92.0 98.0 136.0 112.0 92.0 103.0 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:106.40 Median:97.00 stddev:15.09 (15.6%) stddev-sans-first:15.62 14:12:02 INFO - PROCESS | 1670 | Values: 97.0 97.0 117.0 120.0 97.0 95.0 98.0 97.0 105.0 141.0 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:98.70 Median:89.00 stddev:20.61 (23.2%) stddev-sans-first:21.50 14:12:02 INFO - PROCESS | 1670 | Values: 88.0 90.0 93.0 84.0 136.0 139.0 91.0 91.0 87.0 88.0 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:58.00 stddev:1.48 (2.5%) stddev-sans-first:1.33 14:12:02 INFO - PROCESS | 1670 | Values: 55.0 55.0 58.0 57.0 58.0 59.0 58.0 56.0 57.0 59.0 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:86.00 Median:71.00 stddev:16.15 (22.7%) stddev-sans-first:15.76 14:12:02 INFO - PROCESS | 1670 | Values: 68.0 74.0 71.0 73.0 89.0 107.0 103.0 104.0 100.0 71.0 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:87.00 stddev:9.67 (11.1%) stddev-sans-first:10.20 14:12:02 INFO - PROCESS | 1670 | Values: 87.0 90.0 90.0 86.0 87.0 89.0 80.0 101.0 111.0 78.0 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:161.80 Median:158.50 stddev:23.49 (14.8%) stddev-sans-first:24.11 14:12:02 INFO - PROCESS | 1670 | Values: 145.0 137.0 153.0 159.0 158.0 146.0 152.0 161.0 212.0 195.0 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.50 Median:180.00 stddev:27.67 (15.4%) stddev-sans-first:28.70 14:12:02 INFO - PROCESS | 1670 | Values: 173.0 172.0 175.0 169.0 238.0 244.0 187.0 177.0 177.0 183.0 14:12:02 INFO - PROCESS | 1670 | 14:12:02 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:71.50 stddev:6.77 (9.5%) stddev-sans-first:7.00 14:12:02 INFO - PROCESS | 1670 | Values: 69.0 72.0 73.0 70.0 70.0 71.0 70.0 69.0 78.0 91.0 14:12:02 INFO - PROCESS | 1670 | -------- Summary: end -------- 14:12:02 INFO - PROCESS | 1670 | 14:12:03 INFO - TEST-INFO | 1670: exit 0 14:12:03 INFO - TEST-OK | kraken | took 61242ms 14:12:03 INFO - SUITE-END | took 1177s 14:12:03 INFO - Completed test suite (00:19:37) 14:12:03 INFO - javascript benchmark 14:12:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7125.907187128175, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2937.8237305761654, 3063.724264816166, 3066.417380697666, 3442.9139271518193, 3485.041613556272, 5778.24882765241, 5833.795817146395, 5840.328362238349, 5890.58765886387, 5908.852278693035, 5173.818916337929, 5558.944410555893, 5824.417558244173, 5942.524598032158, 6045.063015232646, 4834.274858771195, 4882.438519570242, 5265.921011184835, 5344.545713614348, 5370.758315875775, 5291.576673866081, 5386.111291636895, 5418.187271909206, 5439.102548079562, 5449.4005659377435, 5383.676979381211, 5387.488188622075, 5391.676499410029, 5447.972760136194, 5487.176923461493, 5198.220266959948, 5221.981713565856, 5262.05283049051, 5293.735313234323, 5326.6005049621435, 4309.82760689572, 5248.21276808478, 5290.973545132289, 5295.152775555893, 5319.0, 5688.402717714622, 5885.323187833411, 5930.644161350289, 5953.245822676506, 5990.490808281302, 6107.886786452548, 6246.750129994794, 6269.185005949197, 6296.338884417116, 6334.081558174039, 6282.308946015934, 6316.526260530432, 6328.936710632881, 6341.302456729756, 6354.3963323484195, 5976.97011514944, 5983.770293360101, 5984.700764961734, 5999.220101386879, 6002.219711437485, 6130.061839218087, 6290.087937249074, 6302.590331628429, 6419.711112999927, 6424.068510066108, 6190.41191086846, 6225.844353891099, 6267.185265915402, 6272.1219029335925, 6312.0531920211415, 4821.590164836029, 5612.494875461228, 6289.937100629027, 6325.493960483151, 6329.525285603599, 6123.83172914054, 6154.230721159855, 6220.626762394271, 6226.470749986212, 6291.087792270187, 6280.591761535577, 6297.086922396227, 6301.0, 6302.527310451735, 6335.65153916539, 5011.323471331323, 5025.974870125626, 5036.6726162799305, 5038.395392552917, 5058.418281897629, 3841.5006049213425, 3894.357431023849, 4480.350349199413, 4567.451905771262, 4572.634189264851, 4607.746573938465, 5018.924716129261, 5235.685858848481, 6038.275406951107, 6050.941085310141, 6258.280297765815, 6287.151234583364, 6307.180066591313, 6336.239651241881, 6431.839204019843, 5871.266091738533, 6008.068749343859, 6050.6369617823075, 6079.08813677943, 6101.877962440726, 5446.618736688394, 5473.781048758005, 5485.725713714299, 5516.779328826802, 5582.804601838916, 6421.197350331208, 6451.129097571956, 6452.806415807533, 6474.449671777952, 6610.2398224204835, 6299.0, 6331.145295385064, 6337.619742815262, 6348.428641422294, 6350.428461438492, 5383.192521121863, 6179.0, 6326.493880489642, 6398.0402939559435, 6399.168108145911, 6235.906461402992, 6290.685465726604, 6324.17785687876, 6329.050642403492, 6330.841728956813, 6233.127362169391, 6284.465820405317, 6309.053641953744, 6320.367963203643, 6346.111544383698, 6133.304060594526, 6136.335271946791, 6140.508759299335, 6206.131141640084, 6242.469390101711, 6210.347913469021, 6242.219722534684, 6283.96858015707, 6299.653519056313, 6301.873962520815, 5350.839474815762, 5812.128180772918, 5972.820815375546, 6036.879262414639, 6176.413240742122, 4972.353594032753, 6155.076738489262, 6227.377262273736, 6307.842303942438, 6311.27420346666, 6147.477464415575, 6177.135201071944, 6184.350643182401, 6202.596831205957, 6208.0], "value": 5740.932426413192, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.62664681578144, 473.32787441832596, 526.8972550352681, 538.1416640458469, 562.7102042448138, 38322.61677383229, 41209.0, 41301.58698413023, 41338.0, 41436.17127657449, 41787.164256714845, 42248.0, 42336.0, 42386.66873321966, 42462.57537424625, 9465.432074075543, 9649.324547281693, 9666.806663866719, 9682.56428460721, 9709.902900971007, 9488.430694158338, 9555.140037396633, 9557.56990935406, 9585.424874507517, 9612.711618651452, 9570.904290957105, 9602.039796020377, 9606.567704453317, 9608.663696770614, 9657.32398732089, 8080.555569443678, 9503.572339244716, 9594.232461403071, 9623.133917947349, 9635.518224088837, 9431.764205894839, 9457.19613832825, 9490.90509094907, 9559.139677428995, 9596.66411675588, 40343.39484907729, 40388.59611403878, 40496.1900761986, 40653.983650408976, 40789.59210407917, 3290.6380298167182, 3321.0626602420234, 3413.1467133216697, 3422.709069729076, 3477.374072666919, 30250.0, 32011.03966880997, 32047.0, 32102.518462223084, 32146.196345091324, 2334.8132149428006, 2566.538023155831, 2887.321479452327, 2897.8261304321595, 2959.2306000439826, 492810.0, 494841.0, 496525.0, 497421.0, 497885.0, 31543.21141971469, 33288.33423331568, 34018.14954626154, 35564.822175888956, 63648.0, 29703.0, 35130.29739405197, 35684.0, 35727.0, 35821.0, 14434.350454229585, 14484.203368814817, 14611.634709132144, 14621.0, 14640.19478928648, 12179.695507612381, 12262.325572093441, 12273.877261227452, 12303.93848030754, 12373.381330933596, 7696.846063078707, 7752.728654497066, 7789.12277549877, 7790.0, 7808.5314881107315, 2771.3071732066983, 3268.2319654881085, 3277.213468767526, 3283.1463819407127, 3295.9011229663147, 896.2740180453853, 950.5437390052675, 988.9764094162507, 1026.6602084279937, 1029.505837198149, 26806.5979010315, 29813.850930745208, 30360.0, 31013.0, 31360.68639313623, 893.5576889439639, 959.9009134540912, 994.9900850636465, 1061.7823346214007, 1087.5921529426464, 14842.332095055748, 15512.767308490382, 16138.273777680033, 16200.837991620168, 16201.270942807367, 651578.0, 651874.0, 652130.0, 658407.0, 658637.0, 59246.0, 59346.0, 59352.0, 59699.701501492214, 59763.0, 1334.8665133486575, 1372.3412761874156, 1377.2081053394338, 1395.6929475515167, 1401.1242973141786, 22590.09639614397, 26600.201993940213, 27234.455310893274, 30435.391292174474, 30503.389932201677, 52437.0, 55076.449235508735, 56534.0, 56702.14946775719, 60212.69893650504, 537246.0, 540242.0, 546582.267088662, 547028.0323369274, 547247.0, 34420.96737097891, 41601.37597936094, 43242.0, 43313.350299744896, 43381.0, 37278.0, 43175.784121079196, 43391.78304108459, 46281.768591156826, 47265.0, 38694.419583705705, 38846.4173037399, 39141.608583913796, 39852.402213966234, 39905.0, 38406.23187536289, 38729.4190587147, 38862.0, 39618.60381396149, 40779.776606701846, 33322.83338583291, 34255.0, 36802.07994800151, 39081.80459097686, 39328.82013539598, 34502.30995380128, 35220.47169292411, 35539.82230088833, 35561.0, 35988.4601730969, 22489.0, 24060.278191654277, 24167.75832241655, 25954.0, 26486.470270594866], "value": 18540.415918871324, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.59015329305424, 375.56246972277296, 376.12738446803417, 381.0568842115764, 403.4956304619226, 18930.33743818965, 19445.513862153453, 19951.700724489143, 20626.071826767795, 20890.791092089075, 15633.296501657424, 15978.600534986632, 18034.09829508526, 18631.441056768286, 20220.494487637818, 4865.635077369203, 5431.945680543204, 6136.846578835521, 6168.814935551918, 6178.258608966908, 5695.401982791809, 6015.578909476339, 6064.4541991220785, 6074.119252708355, 6084.847878803021, 5775.480206781389, 5944.702764861761, 6041.124037014631, 6044.546659000571, 6060.181875446824, 5922.674252916088, 6045.758169673208, 6053.848653783647, 6058.606190597597, 6066.393360663942, 5222.373315202162, 5224.686518808883, 5229.947700522984, 5253.3170687810725, 5529.142982837667, 11749.765004699859, 12007.93996030023, 12052.096092793076, 12217.816732749016, 12294.569690060805, 2198.8240940724704, 2290.4633615333464, 2291.7364503082194, 2445.6576079348906, 2874.9937521867387, 9804.90195098047, 10132.848007279898, 14688.0, 14990.925045374703, 15353.07881527112, 1831.835134837871, 1843.4930394141584, 1866.5426970392205, 1872.5318670332417, 1897.0988780329371, 106865.0, 115741.0, 117211.0, 118071.4096429521, 118507.0, 10282.0, 10687.038166564891, 11524.078073754079, 11581.478833452515, 11623.53505859773, 14339.426422943174, 14359.282035898163, 14413.42346306157, 14431.0, 14436.0, 8298.668053277923, 8436.0, 8457.238848503664, 8460.619272132768, 8579.485230886166, 8313.958430207811, 8324.25081742646, 8334.708285209988, 8451.1548845115, 8487.660493580188, 4463.754493502824, 4553.453585569753, 4569.977150114228, 4570.131674981742, 4604.746738929324, 1911.3883557261543, 1959.9902000490192, 1981.6730239510318, 1988.9701654475195, 2013.6274789163758, 770.5299767142039, 848.1687945813138, 881.7046289492963, 898.9056149104381, 984.6209209454412, 20297.086631101636, 20868.373948781562, 21246.0, 21343.46641333948, 22572.66141007886, 855.2644725536034, 960.2845879819439, 960.4237457525429, 962.4936973636237, 976.1068622210598, 10439.164866810637, 10710.536576587428, 10882.727931801768, 10894.074003709773, 10973.396463194442, 463575.0, 466496.0, 471539.0, 568962.0, 618861.0, 123553.76446235423, 127623.0, 127784.99999999814, 129426.0, 131419.0, 1006.718118926687, 1045.2369770067894, 1091.0017334139332, 1093.8413929980109, 1097.4841824342545, 15881.444149454714, 18676.906615466836, 18896.811031889505, 19589.902050489658, 19640.312589059315, 53001.879924802575, 54905.0, 55214.0, 55861.441385585626, 56367.71816140893, 55940.16089758575, 65280.020799687096, 77654.2234577647, 78050.2194978043, 82641.0, 5959.28488581373, 6427.42153206195, 6949.478789090737, 7962.522248665098, 8261.710840120568, 8927.866082008644, 9232.030636783042, 10483.266171367932, 11476.713082172679, 12932.41804118798, 8247.505149691038, 9531.237501000041, 11082.778344433227, 11650.6504804856, 11700.133467300566, 10859.674209773719, 11160.888391115985, 11231.55073797039, 11510.48202830858, 11689.123315751523, 9550.570224340061, 11338.60314888975, 11586.652400428, 11808.7600801918, 11941.701457463632, 7882.605869706606, 7960.049787802026, 8046.718364857202, 8447.831043379221, 8459.61931713062, 8258.628361723857, 10250.436226007641, 11404.771904561696, 11615.477303521193, 11627.6511704649], "value": 9252.043128492436, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.9066660667058, 1543.3209387869338, 1659.6929568029907, 1759.9912000439997, 1856.0997916010733, 7809.960950195241, 8082.95958520208, 8361.163883611636, 8774.078721734213, 8825.16160964708, 8304.543250121242, 8598.269147122503, 8617.310615150789, 8720.8691869622, 8763.780905477366, 2330.021391015773, 2346.3899386159637, 2354.682117914077, 2356.71719393673, 2364.988175059122, 2355.5642206191824, 2379.8334116611845, 2406.3984003999, 2408.4580969281947, 2418.697662792151, 2346.8239882008834, 2347.438953096189, 2350.553394854972, 2374.7031621047367, 2378.6669866218745, 2037.9694304585369, 2329.6738456616085, 2341.0518739910362, 2345.1088586337255, 2346.0381243690003, 1948.3765195137562, 2364.5625559271416, 2373.133806160739, 2373.394784330002, 2379.619260918245, 8543.700970466067, 8590.398672092893, 8701.216890479887, 8711.172438618385, 8731.912680873236, 5142.305788718512, 5266.473352664703, 5405.702686352249, 5406.189071639246, 5409.648372855791, 3326.534285200074, 3508.19311558343, 3604.495370648085, 3635.272945410902, 3644.0, 952.4142652268874, 1024.08856118055, 1028.3213079367656, 1069.5775168808354, 1077.3159044007034, 11292.378919159442, 11339.603113890975, 11407.0, 11419.714507137305, 11461.255018423775, 4262.318029115327, 4682.6253899687945, 4747.620190384761, 4822.42130944289, 4851.611871050308, 9723.659671911591, 9746.853797193047, 9786.266030047775, 9789.804203915883, 9801.11789938909, 5313.548348390353, 5327.520523152934, 5353.330833645794, 5358.5981051421295, 5365.436629153961, 4357.368181613649, 4412.3160910059, 4836.395450568679, 4854.247591623304, 4861.95138048615, 3814.561325447609, 3867.994321476436, 3935.665468435158, 3943.3690609502914, 3965.6034396560112, 1103.266327891959, 1277.881853378294, 1281.6347341007954, 1297.863724308953, 1302.2902518127644, 843.1020962674731, 899.2176806178536, 916.3127654259306, 917.6100157433198, 933.9346245762731, 5829.446202610745, 5926.377730338339, 5989.341172471112, 6030.48740857032, 6104.560002787499, 419.5741322557607, 425.97231179973824, 429.3066697283864, 432.19611522568624, 443.57416879795113, 3247.886323978649, 3945.4279129526058, 4041.7170798043853, 4050.513938327361, 4066.3087275163293, 10162.695119146438, 10340.534675939602, 10514.421706806046, 10530.15758739299, 10550.0, 10461.372317660966, 10467.790644187073, 10481.947590262, 10490.0, 10496.632617858491, 7104.450861296405, 7871.0, 8171.591420428955, 8207.138250483733, 8246.463979841412, 4404.691671582958, 5035.0, 5799.246098007232, 5876.0, 5918.644881307136, 9455.621775129193, 9581.0, 9642.71071867845, 9699.078587534173, 9716.125548700367, 9712.9028709712, 9745.535448242916, 9766.609335626496, 9866.210703143588, 9889.208863291064, 7323.8535229296185, 7366.77899663011, 7389.704411823467, 7408.333250007525, 7412.274806728235, 7928.722494712657, 7947.165547617417, 7979.5611241382285, 8025.23760242776, 8060.717874874351, 7203.387712044535, 7393.55638661682, 7395.260473952561, 7519.962400187964, 7573.621318933921, 7144.106986626672, 7322.96338518304, 7328.0, 7332.706691732271, 7361.006264154271, 6790.219124800711, 6907.827304317432, 6958.756443524452, 6965.895511567432, 6982.615956122462, 4871.269309603588, 5037.92443113361, 5038.269450929668, 5051.974740126423, 5105.821296254613, 4937.136001199848, 4960.082384758831, 5068.82259120929, 5093.643444958965, 5099.796008159632], "value": 4435.217860993882, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.29130087789304, 302.4510513418147, 303.3750474023512, 314.33204440563804, 315.3094722557597, 4646.930296045562, 5388.218708287296, 5707.971460142699, 5773.3649298577175, 5796.797112101077, 4668.206404911165, 4859.611231101503, 5308.867278318044, 5411.323584551931, 5535.944640553594, 3676.669099781019, 3893.279743247508, 4155.563665815092, 4272.636825869805, 4288.807003684826, 3332.6500717424683, 4017.37730651748, 4278.2940814765525, 4315.892102697442, 4317.956820431787, 3470.4620783778555, 3649.7262705297076, 4157.334826427772, 4158.6465150462245, 4177.582241775828, 3835.8875925981433, 3860.297791545901, 4168.082342360345, 4179.26560477403, 4181.682769927494, 3372.8988130355883, 3597.3704601694863, 3631.8547258109643, 3636.6363363663686, 3639.6906262967677, 4226.0, 4431.7119387240045, 5044.629024358545, 5439.88482361115, 5568.220449137124, 3831.597682243352, 4188.81150348235, 4840.975795121037, 4855.781489832931, 4869.440014398318, 4968.677035992649, 5990.670513121777, 5992.670403127826, 6016.578839481238, 6045.52133625216, 3848.730588858781, 3984.880453586397, 3985.0, 3989.7207195496326, 4009.659178969791, 6208.0, 6256.2492500899725, 6260.593061450991, 6264.3422440643535, 6323.9447179666795, 3263.7225835804225, 3575.3385623659706, 3865.3379047009494, 4047.3321901886447, 4050.5139383274195, 3433.4678124890183, 3456.8617255309505, 3930.678576602766, 4047.2680940365726, 4085.958080689405, 3993.381025940984, 4046.7976601169826, 4683.180443422388, 4805.303231031551, 4845.927311090337, 5714.200011998323, 5751.827445176651, 5872.882542349129, 5983.563944653252, 6072.666003369769, 1188.6018183908316, 1256.7360854220533, 1275.0309764578801, 1320.19468124444, 1383.89620778442, 891.643342662927, 896.4666023715879, 906.6128822900972, 909.8990221831658, 945.5697657565792, 4728.598069164091, 5580.748866301026, 5615.747291371898, 5665.526962989652, 5672.773089076473, 5633.690147041952, 6086.9391306087255, 6166.537509686791, 6176.598521096114, 6184.8971349741305, 4634.6987445816585, 4943.555080042814, 5101.540861322499, 5104.591632669378, 5644.774209031675, 2328.767123287658, 2496.463260399023, 2626.159628918766, 2754.380264440485, 2763.2401089700493, 4626.298960831322, 5219.0074592936435, 5255.500727430888, 5263.763130659129, 5315.6279060465395, 4889.257420302301, 4920.941997470561, 4985.027919555652, 5021.096202683552, 5195.480451954774, 4583.587477127075, 4879.706877677419, 5043.470435604208, 5078.898422031612, 5345.812896548602, 4590.416306374295, 5172.0, 5183.222516622537, 5186.974065129651, 5207.843764687065, 4427.005331576166, 4588.715159755274, 5085.982803439401, 5128.79484820603, 5176.178982454647, 4968.552830245295, 5085.7711402986215, 5297.602679798953, 5325.363944847325, 5386.9529578761385, 3259.755518336087, 3416.4704470807064, 3481.791092534456, 3538.8413068027967, 3563.6436356365193, 3782.659560639556, 5074.289599456005, 5169.578365949394, 5926.111083337361, 6144.743286058396, 5848.718999590078, 5911.586188966731, 6039.758409663565, 6046.758129674764, 6048.758049677964, 6047.425494578008, 6055.9091613626715, 6084.209052823105, 6085.4523092921845, 6134.693265336805, 5477.424870388551, 5549.0, 5809.448102430262, 5896.292444906639, 5953.600903787693, 4852.44196917359, 5253.395859476209, 5922.644641321534, 6028.367021462858, 6050.183225264709, 4636.536346365337, 4826.855194344175, 4870.421803504694, 5243.973780131075, 5801.36185019639], "value": 4069.4740413027434, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.2637796258838, 722.4112348436024, 772.5287574579509, 772.7797577690355, 852.075498084578, 14479.638009049779, 15317.84682153178, 15380.846191538096, 15396.769048464254, 15450.922745386271, 14061.929690351533, 14201.017786264896, 14221.928890355559, 14245.78631320531, 14300.284985750697, 690.4200471603851, 712.6686090967698, 860.371928492201, 874.3180319350901, 877.0659247900996, 745.6868115391549, 856.3791251342789, 885.4510203673731, 885.8405487012335, 887.0154128916897, 909.222614664459, 911.1890417528405, 915.4004127296631, 943.8820147481565, 944.574941276425, 893.8167675626481, 914.090479972425, 921.5346250143668, 939.5255396025032, 939.9859002114973, 669.036587314266, 675.0650349266252, 678.2064983968719, 688.5180373738403, 696.0012382231463, 14369.640758981004, 14571.19858407787, 14674.486392976301, 14713.337899794427, 15035.54893353201, 13922.791158132635, 13955.860441395558, 14011.929940350234, 14093.859061409357, 14502.85497145036, 11333.659990200225, 11456.0, 11537.884621153766, 11594.826077608843, 11645.70885727855, 3740.195857890539, 3744.4944932434046, 3871.2451072040963, 3901.6683581895572, 3935.822887970048, 75778.62110689466, 78522.60738696327, 78541.21458785396, 84685.57657211737, 85267.72098418529, 10775.137988960865, 10900.890991090146, 10902.18233632465, 10911.618093366695, 11089.112870970303, 16904.746428803577, 20766.0, 20940.58118837615, 20994.0, 21045.789542104383, 7849.686012559548, 7936.4047696423, 8038.954935858301, 8153.103158652543, 8200.712975045964, 4355.1507456045765, 4365.6234377552455, 4395.362672412546, 4421.115776844644, 4525.570070843265, 3442.5524681791208, 3537.699295559855, 3557.181848174934, 3557.1996300832625, 3560.732945029133, 607.908813677943, 652.6997581112646, 657.8486948001986, 668.8762578922915, 685.7497013590004, 590.3565114025647, 607.3986753114385, 653.4249860123156, 665.5906617430343, 674.6626686656672, 9035.63857445708, 9071.501067441222, 9074.183323500916, 9219.492927888896, 9443.858342124873, 559.0725155780592, 614.8555089553952, 625.4941055384504, 629.7418058595954, 693.6427739714052, 3577.874774382884, 4050.23045621331, 4134.64855487287, 4268.957310426856, 4329.134173165379, 83234.58382708169, 107866.46066769616, 114153.0, 115042.0, 115220.0, 72697.0, 79146.0, 80592.59703701444, 99040.50479747556, 100332.0, 68382.65808671025, 87001.5649921759, 88570.0, 89500.6574901377, 92144.53927730318, 8629.303117046758, 8768.342374321825, 8775.56122193875, 8792.120787921156, 8879.378443508893, 40944.0, 43324.56675433205, 48983.26525102055, 52982.94034119219, 57243.42756572381, 72347.55304893978, 72940.63529682318, 74858.51414858471, 75391.0, 76244.61877690576, 12490.313032783284, 12652.936735316265, 12734.0, 12864.871351286742, 12941.0, 14106.647333816736, 14141.717165656835, 14193.574192774233, 14284.857151428352, 14387.496437624633, 12984.610461686165, 13059.34703264852, 13187.73624527485, 13661.453541858215, 13737.381817818023, 12930.676733081747, 13261.66845828862, 13302.0, 13621.659458513617, 13812.309384530532, 12598.244105353708, 12968.675783105498, 12974.740505190031, 13443.193408395136, 13546.661333466742, 10021.656928482786, 10449.268551201647, 11207.66377008691, 11237.66588544397, 11314.886851131383, 10436.112930401001, 10928.0, 11146.386948717898, 11205.551777929119, 11210.83183752228], "value": 7365.5340940943115, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 116.0, 118.0, 116.0, 117.0, 120.0, 118.0, 116.0, 119.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 146.0, 164.0, 141.0, 147.0, 141.0, 146.0, 142.0, 113.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 190.0, 206.0, 275.0, 198.0, 187.0, 195.0, 199.0, 194.0, 194.0], "value": 204.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 58.0, 82.0, 62.0, 60.0, 69.0, 60.0, 80.0, 59.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 87.0, 72.0, 68.0, 70.0, 86.0, 68.0, 71.0, 89.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 76.0, 135.0, 132.0, 92.0, 98.0, 136.0, 112.0, 92.0, 103.0], "value": 106.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 117.0, 120.0, 97.0, 95.0, 98.0, 97.0, 105.0, 141.0], "value": 106.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 93.0, 84.0, 136.0, 139.0, 91.0, 91.0, 87.0, 88.0], "value": 98.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 58.0, 57.0, 58.0, 59.0, 58.0, 56.0, 57.0, 59.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 71.0, 73.0, 89.0, 107.0, 103.0, 104.0, 100.0, 71.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 90.0, 86.0, 87.0, 89.0, 80.0, 101.0, 111.0, 78.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 137.0, 153.0, 159.0, 158.0, 146.0, 152.0, 161.0, 212.0, 195.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 175.0, 169.0, 238.0, 244.0, 187.0, 177.0, 177.0, 183.0], "value": 189.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 73.0, 70.0, 70.0, 71.0, 70.0, 69.0, 78.0, 91.0], "value": 73.3, "unit": "score"}]}]} 14:12:03 INFO - Return code: 0 14:12:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:12:03 ERROR - # TBPL SUCCESS # 14:12:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:12:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:12:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:12:04 INFO - 2016-10-26 14:12:04.006 screenresolution[1675:10898] starting screenresolution argv=screenresolution get 14:12:04 INFO - 2016-10-26 14:12:04.008 screenresolution[1675:10898] Display 0: 1600x1200x32@60 14:12:04 INFO - 2016-10-26 14:12:04.015 screenresolution[1676:10901] starting screenresolution argv=screenresolution list 14:12:04 INFO - Available Modes on Display 0 14:12:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:12:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:12:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:12:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:12:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:12:04 INFO - Intel Iris: 14:12:04 INFO - Chipset Model: Intel Iris 14:12:04 INFO - Type: GPU 14:12:04 INFO - Bus: Built-In 14:12:04 INFO - VRAM (Dynamic, Max): 1536 MB 14:12:04 INFO - Vendor: Intel (0x8086) 14:12:04 INFO - Device ID: 0x0a2e 14:12:04 INFO - Revision ID: 0x0009 14:12:04 INFO - Displays: 14:12:04 INFO - Display: 14:12:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:12:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:12:04 INFO - Display Serial Number: 1600x1200 60 14:12:04 INFO - Main Display: Yes 14:12:04 INFO - Mirror: Off 14:12:04 INFO - Online: Yes 14:12:04 INFO - Rotation: Supported 14:12:04 INFO - Return code: 0 14:12:04 INFO - Running post-action listener: _resource_record_post_action 14:12:04 INFO - [mozharness: 2016-10-26 21:12:04.249097Z] Finished run-tests step (success) 14:12:04 INFO - Running post-run listener: _resource_record_post_run 14:12:04 INFO - Total resource usage - Wall time: 1213s; CPU: 55.0%; Read bytes: 39533056; Write bytes: 713778176; Read time: 390; Write time: 1963 14:12:04 INFO - TinderboxPrint: CPU usage
54.6% 14:12:04 INFO - TinderboxPrint: I/O read bytes / time
39,533,056 / 390 14:12:04 INFO - TinderboxPrint: I/O write bytes / time
713,778,176 / 1,963 14:12:04 INFO - TinderboxPrint: CPU idle
2,205.7 (45.4%) 14:12:04 INFO - TinderboxPrint: CPU system
984.1 (20.3%) 14:12:04 INFO - TinderboxPrint: CPU user
1,663.9 (34.3%) 14:12:04 INFO - TinderboxPrint: Swap in / out
446,210,048 / 0 14:12:04 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 399616512; Write bytes: 394565632; Read time: 30447; Write time: 722 14:12:04 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 37440000; Write bytes: 302885888; Read time: 365; Write time: 1199 14:12:04 INFO - Running post-run listener: _upload_blobber_files 14:12:04 INFO - Blob upload gear active. 14:12:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:12:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:12:05 INFO - (blobuploader) - INFO - Open directory for files ... 14:12:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:12:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:12:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:05 INFO - (blobuploader) - INFO - Done attempting. 14:12:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:12:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:12:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:06 INFO - (blobuploader) - INFO - Done attempting. 14:12:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:12:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:12:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:08 INFO - (blobuploader) - INFO - Done attempting. 14:12:08 INFO - (blobuploader) - INFO - Iteration through files over. 14:12:08 INFO - Return code: 0 14:12:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:12:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:12:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a45c9190d314fc3c47215955bf8d05ecf7e7b076fcef356dea702232a7576c10c89312617adb772f7cca910677cd738fe2e33e5c3113d54c93caa2bcf26bc0a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78e974135477f562a887a560cbd8c50cef0ca3878221eb2973bcdc4fa601f2dc6eff2be66fccb56c1d26e6fb19ecbdb8e29dec8678e1483dd455e67d35bcb690", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac9088024cca9b1f4f58b107ab5cd6b4c84a0563a13bee79f851598d87b89d7b1181fe9c328a9c29fe3b3ba0dfc11ee64a0b02c51f0e2703c937036878a6f9fb"} 14:12:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:12:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:12:08 INFO - Contents: 14:12:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a45c9190d314fc3c47215955bf8d05ecf7e7b076fcef356dea702232a7576c10c89312617adb772f7cca910677cd738fe2e33e5c3113d54c93caa2bcf26bc0a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78e974135477f562a887a560cbd8c50cef0ca3878221eb2973bcdc4fa601f2dc6eff2be66fccb56c1d26e6fb19ecbdb8e29dec8678e1483dd455e67d35bcb690", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac9088024cca9b1f4f58b107ab5cd6b4c84a0563a13bee79f851598d87b89d7b1181fe9c328a9c29fe3b3ba0dfc11ee64a0b02c51f0e2703c937036878a6f9fb"} 14:12:08 INFO - Running post-run listener: copy_logs_to_upload_dir 14:12:08 INFO - Copying logs to upload dir... 14:12:08 INFO - mkdir: /builds/slave/test/build/upload/logs 14:12:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.852075 ========= master_lag: 2.48 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-26 14:12:11.443775) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:12:11.448651) ========= 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.d7O0CfrPAy/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.vPDqDHS9qt/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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/Firefox/sha512/a45c9190d314fc3c47215955bf8d05ecf7e7b076fcef356dea702232a7576c10c89312617adb772f7cca910677cd738fe2e33e5c3113d54c93caa2bcf26bc0a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78e974135477f562a887a560cbd8c50cef0ca3878221eb2973bcdc4fa601f2dc6eff2be66fccb56c1d26e6fb19ecbdb8e29dec8678e1483dd455e67d35bcb690", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac9088024cca9b1f4f58b107ab5cd6b4c84a0563a13bee79f851598d87b89d7b1181fe9c328a9c29fe3b3ba0dfc11ee64a0b02c51f0e2703c937036878a6f9fb"} build_url:https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011030 build_url: 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a45c9190d314fc3c47215955bf8d05ecf7e7b076fcef356dea702232a7576c10c89312617adb772f7cca910677cd738fe2e33e5c3113d54c93caa2bcf26bc0a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78e974135477f562a887a560cbd8c50cef0ca3878221eb2973bcdc4fa601f2dc6eff2be66fccb56c1d26e6fb19ecbdb8e29dec8678e1483dd455e67d35bcb690", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac9088024cca9b1f4f58b107ab5cd6b4c84a0563a13bee79f851598d87b89d7b1181fe9c328a9c29fe3b3ba0dfc11ee64a0b02c51f0e2703c937036878a6f9fb"}' ========= master_lag: 0.25 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:12:11.711515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 11 secs) (at 2016-10-26 14:12:11.711861) ========= 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.d7O0CfrPAy/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.vPDqDHS9qt/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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.005085 ========= master_lag: 11.79 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 11 secs) (at 2016-10-26 14:12:23.510425) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:12:23.510729) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:12:23.619358) ========= ========= Total master_lag: 14.59 =========