builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0278 starttime: 1486135908.5 results: success (0) buildid: 20170203051009 builduid: 86bb59a0d4574003b7e31bbf09d704e6 revision: 777a6e437a68ec51296c16ed6f8a8d409ab22480 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 07:31:48.498960) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 07:31:48.499893) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 07:31:48.500480) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 07:31:48.530332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 07:31:48.530856) ========= 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.3akdj9dLAy/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.0w5wjwQETQ/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-03 07:31:48-- 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% 18.9M=0.001s 2017-02-03 07:31:49 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.827122 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 07:31:49.385855) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 07:31:49.386383) ========= 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.3akdj9dLAy/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.0w5wjwQETQ/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.025625 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 07:31:49.464356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 07:31:49.464758) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 777a6e437a68ec51296c16ed6f8a8d409ab22480 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 777a6e437a68ec51296c16ed6f8a8d409ab22480 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3akdj9dLAy/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.0w5wjwQETQ/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-03 07:31:49,576 truncating revision to first 12 chars 2017-02-03 07:31:49,576 Setting DEBUG logging. 2017-02-03 07:31:49,576 attempt 1/10 2017-02-03 07:31:49,576 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/777a6e437a68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 07:31:50,756 unpacking tar archive at: mozilla-beta-777a6e437a68/testing/mozharness/ program finished with exit code 0 elapsedTime=1.436898 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 07:31:50.925837) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 07:31:50.926181) ========= script_repo_revision: 777a6e437a68ec51296c16ed6f8a8d409ab22480 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 07:31:50.926589) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 07:31:50.926864) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 07:31:50.946263) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-03 07:31:50.948231) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3akdj9dLAy/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.0w5wjwQETQ/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 07:31:51 INFO - MultiFileLogger online at 20170203 07:31:51 in /builds/slave/test 07:31:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:31:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:31:51 INFO - {'append_to_log': False, 07:31:51 INFO - 'base_work_dir': '/builds/slave/test', 07:31:51 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:31:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:31:51 INFO - 'branch': 'Mozilla-Beta', 07:31:51 INFO - 'buildbot_json_path': 'buildprops.json', 07:31:51 INFO - 'config_files': ('talos/mac_config.py',), 07:31:51 INFO - 'default_actions': ('clobber', 07:31:51 INFO - 'read-buildbot-config', 07:31:51 INFO - 'download-and-extract', 07:31:51 INFO - 'populate-webroot', 07:31:51 INFO - 'create-virtualenv', 07:31:51 INFO - 'install', 07:31:51 INFO - 'run-tests'), 07:31:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:31:51 INFO - 'download_minidump_stackwalk': True, 07:31:51 INFO - 'download_symbols': 'ondemand', 07:31:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:31:51 INFO - 'tooltool.py': '/tools/tooltool.py', 07:31:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:31:51 INFO - '/tools/misc-python/virtualenv.py')}, 07:31:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:31:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:31:51 INFO - 'installer_path': 'installer.exe', 07:31:51 INFO - 'log_level': 'info', 07:31:51 INFO - 'log_name': 'talos', 07:31:51 INFO - 'log_to_console': True, 07:31:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:31:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:31:51 INFO - 'opt_config_files': (), 07:31:51 INFO - 'pip_index': False, 07:31:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:31:51 INFO - 'cmd': ('bash', 07:31:51 INFO - '-c', 07:31:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:31:51 INFO - 'enabled': True, 07:31:51 INFO - 'halt_on_failure': False, 07:31:51 INFO - 'name': 'check_screen_resolution'},), 07:31:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:31:51 INFO - 'cmd': ('bash', 07:31:51 INFO - '-c', 07:31:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:31:51 INFO - 'enabled': True, 07:31:51 INFO - 'halt_on_failure': False, 07:31:51 INFO - 'name': 'check_screen_resolution'},), 07:31:51 INFO - 'run_cmd_checks_enabled': True, 07:31:51 INFO - 'sps_profile': False, 07:31:51 INFO - 'sps_profile_interval': 0, 07:31:51 INFO - 'suite': 'dromaeojs-e10s', 07:31:51 INFO - 'system_bits': '32', 07:31:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:31:51 INFO - 'title': 't-yosemite-r7-0278', 07:31:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:31:51 INFO - 'use_talos_json': True, 07:31:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:31:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:31:51 INFO - 'work_dir': 'build'} 07:31:51 INFO - [mozharness: 2017-02-03 15:31:51.167178Z] Running clobber step. 07:31:51 INFO - Running pre-action listener: _resource_record_pre_action 07:31:51 INFO - Running main action method: clobber 07:31:51 INFO - rmtree: /builds/slave/test/build 07:31:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:31:53 INFO - Running post-action listener: _resource_record_post_action 07:31:53 INFO - [mozharness: 2017-02-03 15:31:53.634572Z] Finished clobber step (success) 07:31:53 INFO - [mozharness: 2017-02-03 15:31:53.634704Z] Running read-buildbot-config step. 07:31:53 INFO - Running pre-action listener: _resource_record_pre_action 07:31:53 INFO - Running main action method: read_buildbot_config 07:31:53 INFO - Using buildbot properties: 07:31:53 INFO - { 07:31:53 INFO - "project": "", 07:31:53 INFO - "product": "firefox", 07:31:53 INFO - "script_repo_revision": "production", 07:31:53 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 07:31:53 INFO - "repository": "", 07:31:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 07:31:53 INFO - "buildid": "20170203051009", 07:31:53 INFO - "pgo_build": "False", 07:31:53 INFO - "basedir": "/builds/slave/test", 07:31:53 INFO - "buildnumber": 58, 07:31:53 INFO - "slavename": "t-yosemite-r7-0278", 07:31:53 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 07:31:53 INFO - "platform": "yosemite_r7", 07:31:53 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:31:53 INFO - "branch": "mozilla-beta", 07:31:53 INFO - "repo_path": "releases/mozilla-beta", 07:31:53 INFO - "revision": "777a6e437a68ec51296c16ed6f8a8d409ab22480", 07:31:53 INFO - "stage_platform": "macosx64", 07:31:53 INFO - "builduid": "86bb59a0d4574003b7e31bbf09d704e6", 07:31:53 INFO - "slavebuilddir": "test" 07:31:53 INFO - } 07:31:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 07:31:53 INFO - Running post-action listener: _resource_record_post_action 07:31:53 INFO - [mozharness: 2017-02-03 15:31:53.637859Z] Finished read-buildbot-config step (success) 07:31:53 INFO - [mozharness: 2017-02-03 15:31:53.637970Z] Running download-and-extract step. 07:31:53 INFO - Running pre-action listener: _resource_record_pre_action 07:31:53 INFO - Running main action method: download_and_extract 07:31:53 INFO - mkdir: /builds/slave/test/build/tests 07:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:53 INFO - trying https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 07:31:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 07:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 07:31:54 INFO - Downloaded 1165 bytes. 07:31:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 07:31:54 INFO - Using the following test package requirements: 07:31:54 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 07:31:54 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:31:54 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 07:31:54 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:31:54 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 07:31:54 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:31:54 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:31:54 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 07:31:54 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 07:31:54 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:31:54 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 07:31:54 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:31:54 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 07:31:54 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:31:54 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 07:31:54 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:31:54 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 07:31:54 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 07:31:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 07:31:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 07:31:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 07:31:55 INFO - Http code: 200 07:31:55 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 07:31:55 INFO - x-amz-cf-id: hwmiZwTqrV34N-xwidkzXbwIVx7K1zx_rqEExCWPcvmsxpbJS8Vsbw== 07:31:55 INFO - x-amz-version-id: rdZdX4GHA5PSKvp8f_iLqZ4Fv3r1ovY1 07:31:55 INFO - Expected file size: 16092096 07:31:55 INFO - Obtained file size: 16092096 07:32:02 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:32:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 07:32:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 07:32:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 07:32:03 INFO - Http code: 200 07:32:03 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 07:32:03 INFO - x-amz-cf-id: JvCIloSBkoPGK91lJNbT6yMAe9xVrOEhCStAgBV6JipzFKAViRVWIA== 07:32:03 INFO - x-amz-version-id: rdZdX4GHA5PSKvp8f_iLqZ4Fv3r1ovY1 07:32:03 INFO - Expected file size: 16092096 07:32:03 INFO - Obtained file size: 16092096 07:32:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 07:32:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 07:32:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 07:32:10 INFO - Http code: 200 07:32:10 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 07:32:10 INFO - x-amz-cf-id: 6McvibhaI7_aiYoeC5veT1fAhYsTroG0HrPjgsM0BXMYsYJ8RP8mWA== 07:32:10 INFO - x-amz-version-id: GVGB0jC_UBP0ZRsI2zg0GvabemJMlXqv 07:32:11 INFO - Expected file size: 14403005 07:32:11 INFO - Obtained file size: 14403005 07:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:11 INFO - trying https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 07:32:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 07:32:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 07:32:14 INFO - Downloaded 82133874 bytes. 07:32:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 07:32:14 INFO - mkdir: /builds/slave/test/properties 07:32:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:32:14 INFO - Writing to file /builds/slave/test/properties/build_url 07:32:14 INFO - Contents: 07:32:14 INFO - build_url:https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 07:32:15 INFO - Running post-action listener: _resource_record_post_action 07:32:15 INFO - Running post-action listener: set_extra_try_arguments 07:32:15 INFO - [mozharness: 2017-02-03 15:32:15.366850Z] Finished download-and-extract step (success) 07:32:15 INFO - [mozharness: 2017-02-03 15:32:15.366996Z] Running populate-webroot step. 07:32:15 INFO - Running pre-action listener: _resource_record_pre_action 07:32:15 INFO - Running main action method: populate_webroot 07:32:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:32:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:32:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:32:15 INFO - '--tppagecycles', 07:32:15 INFO - '7'], 07:32:15 INFO - 'tests': ['tsvgm']}}, 07:32:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:32:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:32:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:32:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:32:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:32:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:32:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:15 INFO - 'talos_options': ['--disable-e10s'], 07:32:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:15 INFO - 'talos_options': ['--disable-e10s'], 07:32:15 INFO - 'tests': ['damp', 'tps']}, 07:32:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:15 INFO - 'tests': ['damp', 'tps']}, 07:32:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:32:15 INFO - 'tests': ['dromaeo_dom']}, 07:32:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:32:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:32:15 INFO - 'tests': ['basic_compositor_video']}, 07:32:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:32:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:32:15 INFO - 'tests': ['a11yr', 07:32:15 INFO - 'ts_paint', 07:32:15 INFO - 'tpaint', 07:32:15 INFO - 'sessionrestore', 07:32:15 INFO - 'sessionrestore_no_auto_restore', 07:32:15 INFO - 'tabpaint']}, 07:32:15 INFO - 'other-e10s': {'tests': ['a11yr', 07:32:15 INFO - 'ts_paint', 07:32:15 INFO - 'tpaint', 07:32:15 INFO - 'sessionrestore', 07:32:15 INFO - 'sessionrestore_no_auto_restore', 07:32:15 INFO - 'tabpaint']}, 07:32:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:32:15 INFO - 'ts_paint', 07:32:15 INFO - 'tpaint', 07:32:15 INFO - 'sessionrestore', 07:32:15 INFO - 'sessionrestore_no_auto_restore', 07:32:15 INFO - 'tabpaint']}, 07:32:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:32:15 INFO - 'ts_paint', 07:32:15 INFO - 'tpaint', 07:32:15 INFO - 'sessionrestore', 07:32:15 INFO - 'sessionrestore_no_auto_restore', 07:32:15 INFO - 'tabpaint']}, 07:32:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:32:15 INFO - 'tests': ['a11yr', 07:32:15 INFO - 'ts_paint', 07:32:15 INFO - 'tpaint', 07:32:15 INFO - 'sessionrestore', 07:32:15 INFO - 'sessionrestore_no_auto_restore', 07:32:15 INFO - 'tabpaint']}, 07:32:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:32:15 INFO - 'tests': ['a11yr', 07:32:15 INFO - 'ts_paint', 07:32:15 INFO - 'tpaint', 07:32:15 INFO - 'sessionrestore', 07:32:15 INFO - 'sessionrestore_no_auto_restore', 07:32:15 INFO - 'tabpaint']}, 07:32:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:32:15 INFO - 'tests': ['tsvgx', 07:32:15 INFO - 'tsvgr_opacity', 07:32:15 INFO - 'tart', 07:32:15 INFO - 'tscrollx', 07:32:15 INFO - 'cart']}, 07:32:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:32:15 INFO - 'tsvgr_opacity', 07:32:15 INFO - 'tart', 07:32:15 INFO - 'tscrollx', 07:32:15 INFO - 'cart']}, 07:32:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:15 INFO - 'talos_options': ['--disable-e10s'], 07:32:15 INFO - 'tests': ['tp5o']}, 07:32:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:15 INFO - 'tests': ['tp5o']}, 07:32:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:15 INFO - 'talos_options': ['--disable-e10s', 07:32:15 INFO - '--xperf_path', 07:32:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:15 INFO - 'tests': ['tp5n']}, 07:32:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:15 INFO - 'talos_options': ['--xperf_path', 07:32:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:15 INFO - 'tests': ['tp5n']}}, 07:32:15 INFO - 'talos.zip': {'path': '', 07:32:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:32:15 INFO - Running post-action listener: _resource_record_post_action 07:32:15 INFO - [mozharness: 2017-02-03 15:32:15.385711Z] Finished populate-webroot step (success) 07:32:15 INFO - [mozharness: 2017-02-03 15:32:15.385841Z] Running create-virtualenv step. 07:32:15 INFO - Running pre-action listener: _resource_record_pre_action 07:32:15 INFO - Running main action method: create_virtualenv 07:32:15 INFO - Creating virtualenv /builds/slave/test/build/venv 07:32:15 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 07:32:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:32:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:32:15 INFO - Using real prefix '/tools/python27' 07:32:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:32:16 INFO - Installing distribute.............................................................................................................................................................................................done. 07:32:19 INFO - Installing pip.................done. 07:32:19 INFO - Return code: 0 07:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:32:19 INFO - Reading from file tmpfile_stdout 07:32:19 INFO - Output received: 07:32:19 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) 07:32:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:19 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 0x107a91490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a07570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40956eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a5d30>, '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 0x10770bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10789db20>, '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.3akdj9dLAy/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.0w5wjwQETQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 07:32:19 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 07:32:19 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 07:32:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3akdj9dLAy/Render', 07:32:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:19 INFO - 'HOME': '/Users/cltbld', 07:32:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:19 INFO - 'LOGNAME': 'cltbld', 07:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:19 INFO - 'MOZ_NO_REMOTE': '1', 07:32:19 INFO - 'NO_EM_RESTART': '1', 07:32:19 INFO - 'PAGER': '/bin/cat', 07:32:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:19 INFO - 'PWD': '/builds/slave/test', 07:32:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:19 INFO - 'SHELL': '/bin/bash', 07:32:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0w5wjwQETQ/Listeners', 07:32:19 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 07:32:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:19 INFO - 'USER': 'cltbld', 07:32:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:19 INFO - 'XPC_FLAGS': '0x0', 07:32:19 INFO - 'XPC_SERVICE_NAME': '0', 07:32:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:19 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 07:32:19 INFO - Cleaning up... 07:32:19 INFO - Return code: 0 07:32:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:19 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 0x107a91490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a07570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40956eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a5d30>, '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 0x10770bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10789db20>, '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.3akdj9dLAy/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.0w5wjwQETQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 07:32:19 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 07:32:19 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 07:32:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3akdj9dLAy/Render', 07:32:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:19 INFO - 'HOME': '/Users/cltbld', 07:32:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:19 INFO - 'LOGNAME': 'cltbld', 07:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:19 INFO - 'MOZ_NO_REMOTE': '1', 07:32:19 INFO - 'NO_EM_RESTART': '1', 07:32:19 INFO - 'PAGER': '/bin/cat', 07:32:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:19 INFO - 'PWD': '/builds/slave/test', 07:32:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:19 INFO - 'SHELL': '/bin/bash', 07:32:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0w5wjwQETQ/Listeners', 07:32:19 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 07:32:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:19 INFO - 'USER': 'cltbld', 07:32:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:19 INFO - 'XPC_FLAGS': '0x0', 07:32:19 INFO - 'XPC_SERVICE_NAME': '0', 07:32:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:19 INFO - Downloading/unpacking psutil>=3.1.1 07:32:19 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 07:32:19 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 07:32:19 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 07:32:19 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 07:32:19 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 07:32:19 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 07:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:32:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:23 INFO - Installing collected packages: psutil 07:32:23 INFO - Running setup.py install for psutil 07:32:23 INFO - building 'psutil._psutil_osx' extension 07:32:23 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 07:32:24 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 07:32:24 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 07:32:24 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 07:32:24 INFO - building 'psutil._psutil_posix' extension 07:32:24 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 07:32:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:32:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:32:24 INFO - ^ 07:32:24 INFO - 1 warning generated. 07:32:24 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 07:32:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:24 INFO - Successfully installed psutil 07:32:24 INFO - Cleaning up... 07:32:25 INFO - Return code: 0 07:32:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:32:25 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')]} 07:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:25 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')]} 07:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:25 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 0x107a91490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a07570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40956eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a5d30>, '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 0x10770bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10789db20>, '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.3akdj9dLAy/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.0w5wjwQETQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 07:32:25 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 07:32:25 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 07:32:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3akdj9dLAy/Render', 07:32:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:25 INFO - 'HOME': '/Users/cltbld', 07:32:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:25 INFO - 'LOGNAME': 'cltbld', 07:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:25 INFO - 'MOZ_NO_REMOTE': '1', 07:32:25 INFO - 'NO_EM_RESTART': '1', 07:32:25 INFO - 'PAGER': '/bin/cat', 07:32:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:25 INFO - 'PWD': '/builds/slave/test', 07:32:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:25 INFO - 'SHELL': '/bin/bash', 07:32:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0w5wjwQETQ/Listeners', 07:32:25 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 07:32:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:25 INFO - 'USER': 'cltbld', 07:32:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:25 INFO - 'XPC_FLAGS': '0x0', 07:32:25 INFO - 'XPC_SERVICE_NAME': '0', 07:32:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:32:25 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 07:32:25 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 07:32:25 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 07:32:25 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 07:32:25 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 07:32:25 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 07:32:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:32:28 INFO - Installing collected packages: mozsystemmonitor 07:32:28 INFO - Running setup.py install for mozsystemmonitor 07:32:28 INFO - Successfully installed mozsystemmonitor 07:32:28 INFO - Cleaning up... 07:32:28 INFO - Return code: 0 07:32:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:32:28 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')]} 07:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:28 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')]} 07:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:28 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 0x107a91490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a07570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40956eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a5d30>, '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 0x10770bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10789db20>, '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.3akdj9dLAy/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.0w5wjwQETQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 07:32:28 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 07:32:28 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 07:32:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3akdj9dLAy/Render', 07:32:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:28 INFO - 'HOME': '/Users/cltbld', 07:32:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:28 INFO - 'LOGNAME': 'cltbld', 07:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:28 INFO - 'MOZ_NO_REMOTE': '1', 07:32:28 INFO - 'NO_EM_RESTART': '1', 07:32:28 INFO - 'PAGER': '/bin/cat', 07:32:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:28 INFO - 'PWD': '/builds/slave/test', 07:32:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:28 INFO - 'SHELL': '/bin/bash', 07:32:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0w5wjwQETQ/Listeners', 07:32:28 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 07:32:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:28 INFO - 'USER': 'cltbld', 07:32:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:28 INFO - 'XPC_FLAGS': '0x0', 07:32:28 INFO - 'XPC_SERVICE_NAME': '0', 07:32:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:28 INFO - Downloading/unpacking jsonschema==2.5.1 07:32:28 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 07:32:28 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 07:32:28 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 07:32:28 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 07:32:28 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 07:32:28 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 07:32:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:32:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:32:31 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 07:32:31 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 07:32:31 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 07:32:31 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 07:32:31 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 07:32:31 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 07:32:31 INFO - Downloading functools32-3.2.3-2.tar.gz 07:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:32:31 INFO - warning: no files found matching '*.txt' 07:32:31 INFO - no previously-included directories found matching 'build' 07:32:31 INFO - no previously-included directories found matching 'dist' 07:32:31 INFO - no previously-included directories found matching '.git*' 07:32:31 INFO - Installing collected packages: jsonschema, functools32 07:32:31 INFO - Running setup.py install for functools32 07:32:31 INFO - warning: no files found matching '*.txt' 07:32:31 INFO - no previously-included directories found matching 'build' 07:32:31 INFO - no previously-included directories found matching 'dist' 07:32:31 INFO - no previously-included directories found matching '.git*' 07:32:31 INFO - Successfully installed jsonschema functools32 07:32:31 INFO - Cleaning up... 07:32:32 INFO - Return code: 0 07:32:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:32:32 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')]} 07:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:32 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')]} 07:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:32 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 0x107a91490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a07570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40956eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a5d30>, '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 0x10770bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10789db20>, '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.3akdj9dLAy/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.0w5wjwQETQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 07:32:32 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 07:32:32 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 07:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3akdj9dLAy/Render', 07:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:32 INFO - 'HOME': '/Users/cltbld', 07:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:32 INFO - 'LOGNAME': 'cltbld', 07:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:32 INFO - 'MOZ_NO_REMOTE': '1', 07:32:32 INFO - 'NO_EM_RESTART': '1', 07:32:32 INFO - 'PAGER': '/bin/cat', 07:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:32 INFO - 'PWD': '/builds/slave/test', 07:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:32 INFO - 'SHELL': '/bin/bash', 07:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0w5wjwQETQ/Listeners', 07:32:32 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 07:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:32 INFO - 'USER': 'cltbld', 07:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:32 INFO - 'XPC_FLAGS': '0x0', 07:32:32 INFO - 'XPC_SERVICE_NAME': '0', 07:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:32:32 INFO - Cleaning up... 07:32:32 INFO - Return code: 0 07:32:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:32:32 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')]} 07:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:32 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')]} 07:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:32 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 0x107a91490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a07570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40956eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a5d30>, '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 0x10770bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10789db20>, '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.3akdj9dLAy/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.0w5wjwQETQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 07:32:32 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 07:32:32 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 07:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3akdj9dLAy/Render', 07:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:32 INFO - 'HOME': '/Users/cltbld', 07:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:32 INFO - 'LOGNAME': 'cltbld', 07:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:32 INFO - 'MOZ_NO_REMOTE': '1', 07:32:32 INFO - 'NO_EM_RESTART': '1', 07:32:32 INFO - 'PAGER': '/bin/cat', 07:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:32 INFO - 'PWD': '/builds/slave/test', 07:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:32 INFO - 'SHELL': '/bin/bash', 07:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0w5wjwQETQ/Listeners', 07:32:32 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 07:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:32 INFO - 'USER': 'cltbld', 07:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:32 INFO - 'XPC_FLAGS': '0x0', 07:32:32 INFO - 'XPC_SERVICE_NAME': '0', 07:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:32 INFO - Downloading/unpacking blobuploader==1.2.4 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:35 INFO - Downloading blobuploader-1.2.4.tar.gz 07:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:32:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:32:35 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 07:32:35 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 07:32:35 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 07:32:35 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 07:32:35 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 07:32:35 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 07:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:32:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:32:35 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 07:32:35 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 07:32:35 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 07:32:35 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 07:32:35 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 07:32:35 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 07:32:36 INFO - Downloading docopt-0.6.1.tar.gz 07:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:32:36 INFO - Installing collected packages: blobuploader, requests, docopt 07:32:36 INFO - Running setup.py install for blobuploader 07:32:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:32:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:32:36 INFO - Running setup.py install for requests 07:32:37 INFO - Running setup.py install for docopt 07:32:37 INFO - Successfully installed blobuploader requests docopt 07:32:37 INFO - Cleaning up... 07:32:37 INFO - Return code: 0 07:32:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:37 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 0x107a91490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a07570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40956eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a5d30>, '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 0x10770bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10789db20>, '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.3akdj9dLAy/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.0w5wjwQETQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 07:32:37 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 07:32:37 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 07:32:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3akdj9dLAy/Render', 07:32:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:37 INFO - 'HOME': '/Users/cltbld', 07:32:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:37 INFO - 'LOGNAME': 'cltbld', 07:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:37 INFO - 'MOZ_NO_REMOTE': '1', 07:32:37 INFO - 'NO_EM_RESTART': '1', 07:32:37 INFO - 'PAGER': '/bin/cat', 07:32:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:37 INFO - 'PWD': '/builds/slave/test', 07:32:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:37 INFO - 'SHELL': '/bin/bash', 07:32:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0w5wjwQETQ/Listeners', 07:32:37 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 07:32:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:37 INFO - 'USER': 'cltbld', 07:32:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:37 INFO - 'XPC_FLAGS': '0x0', 07:32:37 INFO - 'XPC_SERVICE_NAME': '0', 07:32:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:32:37 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-PePHdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:32:37 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-O2IYPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:32:37 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-LiSKI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:32:37 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-hniZJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:32:38 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-ACEqqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:32:38 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-2zrBvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:32:38 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-qYKWIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:32:38 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-DO7JVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:32:38 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-oI_U_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:32:38 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-t5QvJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:32:38 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-bPBjER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:32:38 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-f946xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:32:38 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-p6ERaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:32:39 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-7rWH2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:39 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-pSraOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:32:39 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-EwMk71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:32:39 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-kSJ6C8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:32:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:32:39 INFO - Running setup.py install for manifestparser 07:32:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:32:39 INFO - Running setup.py install for mozcrash 07:32:39 INFO - Running setup.py install for mozdebug 07:32:39 INFO - Running setup.py install for mozdevice 07:32:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:32:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:32:40 INFO - Running setup.py install for mozfile 07:32:40 INFO - Running setup.py install for mozhttpd 07:32:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:32:40 INFO - Running setup.py install for mozinfo 07:32:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:32:40 INFO - Running setup.py install for mozInstall 07:32:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:32:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:32:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:32:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:32:40 INFO - Running setup.py install for mozleak 07:32:40 INFO - Running setup.py install for mozlog 07:32:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:32:40 INFO - Running setup.py install for moznetwork 07:32:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:32:41 INFO - Running setup.py install for mozprocess 07:32:41 INFO - Running setup.py install for mozprofile 07:32:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:32:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:32:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:32:41 INFO - Running setup.py install for mozrunner 07:32:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:32:41 INFO - Running setup.py install for mozscreenshot 07:32:41 INFO - Running setup.py install for moztest 07:32:41 INFO - Running setup.py install for mozversion 07:32:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:32:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:32:42 INFO - Cleaning up... 07:32:42 INFO - Return code: 0 07:32:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:42 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 0x107a91490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a07570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40956eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a5d30>, '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 0x10770bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10789db20>, '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.3akdj9dLAy/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.0w5wjwQETQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 07:32:42 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 07:32:42 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 07:32:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3akdj9dLAy/Render', 07:32:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:42 INFO - 'HOME': '/Users/cltbld', 07:32:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:42 INFO - 'LOGNAME': 'cltbld', 07:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:42 INFO - 'MOZ_NO_REMOTE': '1', 07:32:42 INFO - 'NO_EM_RESTART': '1', 07:32:42 INFO - 'PAGER': '/bin/cat', 07:32:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:42 INFO - 'PWD': '/builds/slave/test', 07:32:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:42 INFO - 'SHELL': '/bin/bash', 07:32:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0w5wjwQETQ/Listeners', 07:32:42 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 07:32:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:42 INFO - 'USER': 'cltbld', 07:32:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:42 INFO - 'XPC_FLAGS': '0x0', 07:32:42 INFO - 'XPC_SERVICE_NAME': '0', 07:32:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:32:42 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-6HUnlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:32:42 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)) 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:32:42 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-fimB37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:32:42 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-EEWW_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:32:42 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)) 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:32:42 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-di_uA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:32:42 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)) 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:32:42 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-HkE6O7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:32:42 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)) 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:32:42 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-8e02M3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:32:42 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)) 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:32:42 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-vpO_d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:32:43 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)) 07:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:32:43 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-cAtK6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:32:43 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)) 07:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:32:43 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-qhc1GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:32:43 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)) 07:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:32:43 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-y5uAUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:32:43 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)) 07:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:32:43 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-HlvtUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:32:43 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)) 07:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:32:43 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Aq3IXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:32:43 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)) 07:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:32:43 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-XQLYxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:32:43 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)) 07:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:32:43 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-JHN1uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:43 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-yZm3dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:43 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)) 07:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:32:43 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-IG_QPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:32:44 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-TL5WCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:32:44 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)) 07:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:32:44 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)) 07:32:44 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)) 07:32:44 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)) 07:32:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:46 INFO - Downloading blessings-1.6.tar.gz 07:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:32:47 INFO - Installing collected packages: blessings 07:32:47 INFO - Running setup.py install for blessings 07:32:47 INFO - Successfully installed blessings 07:32:47 INFO - Cleaning up... 07:32:47 INFO - Return code: 0 07:32:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:32:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:32:47 INFO - Reading from file tmpfile_stdout 07:32:47 INFO - Current package versions: 07:32:47 INFO - blessings == 1.6 07:32:47 INFO - blobuploader == 1.2.4 07:32:47 INFO - docopt == 0.6.1 07:32:47 INFO - functools32 == 3.2.3-2 07:32:47 INFO - jsonschema == 2.5.1 07:32:47 INFO - manifestparser == 1.1 07:32:47 INFO - mozInstall == 1.12 07:32:47 INFO - mozcrash == 1.0 07:32:47 INFO - mozdebug == 0.1 07:32:47 INFO - mozdevice == 0.48 07:32:47 INFO - mozfile == 1.2 07:32:47 INFO - mozhttpd == 0.7 07:32:47 INFO - mozinfo == 0.9 07:32:47 INFO - mozleak == 0.1 07:32:47 INFO - mozlog == 3.4 07:32:47 INFO - moznetwork == 0.27 07:32:47 INFO - mozprocess == 0.23 07:32:47 INFO - mozprofile == 0.28 07:32:47 INFO - mozrunner == 6.13 07:32:47 INFO - mozscreenshot == 0.1 07:32:47 INFO - mozsystemmonitor == 0.3 07:32:47 INFO - moztest == 0.8 07:32:47 INFO - mozversion == 1.4 07:32:47 INFO - psutil == 3.1.1 07:32:47 INFO - requests == 1.2.3 07:32:47 INFO - wsgiref == 0.1.2 07:32:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:47 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 0x107a91490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a07570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40956eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a5d30>, '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 0x10770bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10789db20>, '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.3akdj9dLAy/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.0w5wjwQETQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 07:32:47 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 07:32:47 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 07:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3akdj9dLAy/Render', 07:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:47 INFO - 'HOME': '/Users/cltbld', 07:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:47 INFO - 'LOGNAME': 'cltbld', 07:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:47 INFO - 'MOZ_NO_REMOTE': '1', 07:32:47 INFO - 'NO_EM_RESTART': '1', 07:32:47 INFO - 'PAGER': '/bin/cat', 07:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:47 INFO - 'PWD': '/builds/slave/test', 07:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:47 INFO - 'SHELL': '/bin/bash', 07:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0w5wjwQETQ/Listeners', 07:32:47 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 07:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:47 INFO - 'USER': 'cltbld', 07:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:47 INFO - 'XPC_FLAGS': '0x0', 07:32:47 INFO - 'XPC_SERVICE_NAME': '0', 07:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:47 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)) 07:32:47 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)) 07:32:47 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)) 07:32:47 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)) 07:32:47 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)) 07:32:47 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)) 07:32:47 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)) 07:32:47 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)) 07:32:47 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)) 07:32:47 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)) 07:32:47 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)) 07:32:47 INFO - Cleaning up... 07:32:47 INFO - Return code: 0 07:32:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:47 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 0x107a91490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a07570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40956eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a5d30>, '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 0x10770bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10789db20>, '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.3akdj9dLAy/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.0w5wjwQETQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 07:32:47 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 07:32:47 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 07:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3akdj9dLAy/Render', 07:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:47 INFO - 'HOME': '/Users/cltbld', 07:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:47 INFO - 'LOGNAME': 'cltbld', 07:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:47 INFO - 'MOZ_NO_REMOTE': '1', 07:32:47 INFO - 'NO_EM_RESTART': '1', 07:32:47 INFO - 'PAGER': '/bin/cat', 07:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:47 INFO - 'PWD': '/builds/slave/test', 07:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:47 INFO - 'SHELL': '/bin/bash', 07:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0w5wjwQETQ/Listeners', 07:32:47 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 07:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:47 INFO - 'USER': 'cltbld', 07:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:47 INFO - 'XPC_FLAGS': '0x0', 07:32:47 INFO - 'XPC_SERVICE_NAME': '0', 07:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:32:48 INFO - Cleaning up... 07:32:48 INFO - Return code: 0 07:32:48 INFO - Running post-action listener: _resource_record_post_action 07:32:48 INFO - Running post-action listener: _start_resource_monitoring 07:32:48 INFO - Starting resource monitoring. 07:32:48 INFO - [mozharness: 2017-02-03 15:32:48.136573Z] Finished create-virtualenv step (success) 07:32:48 INFO - [mozharness: 2017-02-03 15:32:48.137631Z] Running install step. 07:32:48 INFO - Running pre-action listener: _resource_record_pre_action 07:32:48 INFO - Running main action method: install 07:32:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:32:48 INFO - Reading from file tmpfile_stdout 07:32:48 INFO - Detecting whether we're running mozinstall >=1.0... 07:32:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:32:48 INFO - Reading from file tmpfile_stdout 07:32:48 INFO - Output received: 07:32:48 INFO - Usage: mozinstall [options] installer 07:32:48 INFO - Options: 07:32:48 INFO - -h, --help show this help message and exit 07:32:48 INFO - -d DEST, --destination=DEST 07:32:48 INFO - Directory to install application into. [default: 07:32:48 INFO - "/builds/slave/test"] 07:32:48 INFO - --app=APP Application being installed. [default: firefox] 07:32:48 INFO - mkdir: /builds/slave/test/build/application 07:32:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:33:09 INFO - Reading from file tmpfile_stdout 07:33:09 INFO - Output received: 07:33:09 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:33:09 INFO - Running post-action listener: _resource_record_post_action 07:33:09 INFO - [mozharness: 2017-02-03 15:33:09.998055Z] Finished install step (success) 07:33:09 INFO - [mozharness: 2017-02-03 15:33:09.998205Z] Running run-tests step. 07:33:09 INFO - Running pre-action listener: _resource_record_pre_action 07:33:09 INFO - Running main action method: run_tests 07:33:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:33:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:33:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:33:10 INFO - 2017-02-03 07:33:10.012 screenresolution[1698:8062] starting screenresolution argv=screenresolution get 07:33:10 INFO - 2017-02-03 07:33:10.015 screenresolution[1698:8062] Display 0: 1600x1200x32@60 07:33:10 INFO - 2017-02-03 07:33:10.020 screenresolution[1699:8064] starting screenresolution argv=screenresolution list 07:33:10 INFO - Available Modes on Display 0 07:33:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:33:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:33:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:33:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:33:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:33:10 INFO - Intel Iris: 07:33:10 INFO - Chipset Model: Intel Iris 07:33:10 INFO - Type: GPU 07:33:10 INFO - Bus: Built-In 07:33:10 INFO - VRAM (Dynamic, Max): 1536 MB 07:33:10 INFO - Vendor: Intel (0x8086) 07:33:10 INFO - Device ID: 0x0a2e 07:33:10 INFO - Revision ID: 0x0009 07:33:10 INFO - Displays: 07:33:10 INFO - Display: 07:33:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:33:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:33:10 INFO - Display Serial Number: 1600x1200 60 07:33:10 INFO - Main Display: Yes 07:33:10 INFO - Mirror: Off 07:33:10 INFO - Online: Yes 07:33:10 INFO - Rotation: Supported 07:33:10 INFO - Return code: 0 07:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:33:10 INFO - Python 2.7.3 07:33:10 INFO - Return code: 0 07:33:10 INFO - grabbing minidump binary from tooltool 07:33:10 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')]} 07:33:10 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 0x1078a5d30>, '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 0x10770bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10789db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:33:10 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 07:33:10 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 07:33:10 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 07:33:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:33:10 INFO - Return code: 0 07:33:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:33:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:33:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:33:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:33:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--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 07:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0278 --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 07:33:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3akdj9dLAy/Render', 07:33:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:10 INFO - 'HOME': '/Users/cltbld', 07:33:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:10 INFO - 'LOGNAME': 'cltbld', 07:33:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:33:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:10 INFO - 'MOZ_NO_REMOTE': '1', 07:33:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:33:10 INFO - 'NO_EM_RESTART': '1', 07:33:10 INFO - 'PAGER': '/bin/cat', 07:33:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:10 INFO - 'PWD': '/builds/slave/test', 07:33:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:33:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:10 INFO - 'SHELL': '/bin/bash', 07:33:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0w5wjwQETQ/Listeners', 07:33:10 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 07:33:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:10 INFO - 'USER': 'cltbld', 07:33:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:10 INFO - 'XPC_FLAGS': '0x0', 07:33:10 INFO - 'XPC_SERVICE_NAME': '0', 07:33:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--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 07:33:10 INFO - mozversion application_buildid: 20170203051009 07:33:10 INFO - mozversion application_changeset: 777a6e437a68ec51296c16ed6f8a8d409ab22480 07:33:10 INFO - mozversion application_display_name: Firefox 07:33:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:33:10 INFO - mozversion application_name: Firefox 07:33:10 INFO - mozversion application_remotingname: firefox 07:33:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:33:10 INFO - mozversion application_vendor: Mozilla 07:33:10 INFO - mozversion application_version: 52.0 07:33:10 INFO - mozversion platform_buildid: 20170203051009 07:33:10 INFO - mozversion platform_changeset: 777a6e437a68ec51296c16ed6f8a8d409ab22480 07:33:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:33:10 INFO - mozversion platform_version: 52.0 07:33:10 INFO - using testdate: 1486135990 07:33:10 INFO - actual date: 1486135990 07:33:10 INFO - starting webserver on 'localhost:49236' 07:33:10 INFO - SUITE-START | Running 2 tests 07:33:10 INFO - TEST-START | dromaeo_css 07:33:10 INFO - operating with platform_type : mac_ 07:33:10 INFO - Initialising browser for dromaeo_css test... 07:33:10 INFO - TEST-INFO | started process 1709 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpcPJhFi/profile http://localhost:49236/getInfo.html) 07:33:13 INFO - PROCESS | 1709 | 2017-02-03 07:33:13.834 plugin-container[1712:8240] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a4f, name = 'com.apple.tsm.portname' 07:33:13 INFO - PROCESS | 1709 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:13 INFO - PROCESS | 1709 | 2017-02-03 07:33:13.835 plugin-container[1712:8240] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c13, name = 'com.apple.CFPasteboardClient' 07:33:13 INFO - PROCESS | 1709 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:13 INFO - PROCESS | 1709 | 2017-02-03 07:33:13.835 plugin-container[1712:8240] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:33:13 INFO - PROCESS | 1709 | __metrics Screen width/height:1600/1200 07:33:13 INFO - PROCESS | 1709 | colorDepth:24 07:33:13 INFO - PROCESS | 1709 | Browser inner width/height: 1024/689 07:33:13 INFO - PROCESS | 1709 | __metrics 07:33:14 ERROR - PROCESS | 1709 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 07:33:14 INFO - TEST-INFO | 1709: exit 0 07:33:14 INFO - Browser initialized. 07:33:14 INFO - Running cycle 1/1 for dromaeo_css test... 07:33:14 INFO - TEST-INFO | started process 1715 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpcPJhFi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:17 INFO - PROCESS | 1715 | 2017-02-03 07:33:17.375 plugin-container[1716:8378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 07:33:17 INFO - PROCESS | 1715 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:17 INFO - PROCESS | 1715 | 2017-02-03 07:33:17.376 plugin-container[1716:8378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8917, name = 'com.apple.CFPasteboardClient' 07:33:17 INFO - PROCESS | 1715 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:17 INFO - PROCESS | 1715 | 2017-02-03 07:33:17.376 plugin-container[1716:8378] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:33:27 INFO - PROCESS | 1715 | RSS: Main: 177434624 07:33:27 INFO - PROCESS | 1715 | 07:36:29 INFO - PROCESS | 1715 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 07:36:31 INFO - PROCESS | 1715 | RSS: Main: 182616064 07:36:31 INFO - PROCESS | 1715 | 07:39:33 INFO - PROCESS | 1715 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 07:39:33 INFO - PROCESS | 1715 | RSS: Main: 197357568 07:39:33 INFO - PROCESS | 1715 | 07:42:35 INFO - PROCESS | 1715 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 07:42:36 INFO - PROCESS | 1715 | RSS: Main: 199069696 07:42:36 INFO - PROCESS | 1715 | 07:45:38 INFO - PROCESS | 1715 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 07:45:38 INFO - PROCESS | 1715 | RSS: Main: 202326016 07:45:38 INFO - PROCESS | 1715 | 07:48:41 INFO - PROCESS | 1715 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 07:48:42 INFO - PROCESS | 1715 | RSS: Main: 204034048 07:48:42 INFO - PROCESS | 1715 | 07:51:44 INFO - PROCESS | 1715 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 07:51:45 INFO - PROCESS | 1715 | RSS: Main: 204435456 07:51:45 INFO - PROCESS | 1715 | 07:51:45 INFO - PROCESS | 1715 | __start_tp_report 07:51:45 INFO - PROCESS | 1715 | _x_x_mozilla_page_load 07:51:45 INFO - PROCESS | 1715 | _x_x_mozilla_page_load_details 07:51:45 INFO - PROCESS | 1715 | |i|pagename|runs| 07:51:45 INFO - PROCESS | 1715 | |0;dojo.html;3561.76848504847;3565.233474802917;3594.2631760489094;3607.9458808117865;3632.019354774209;5959;5975.790847320339;5988.910166347503;6011.338752737206;6022.126791615213;5931.110333449985;6006.45941865232;6030.125631783389;6049.941260279445;6078.088286756989;5261.473852614737;5387.973060134694;5388.407275199725;5397.8380648580605;5474;4535.387722657432;5123.871903202413;5450;5462.20797984292;5464.26232458619;5280.128778751501;5304.177852432879;5335.599830012745;5437.945620543804;5457.945420545783;5375.354957405137;5377.166539186433;5419.891602167974;5464.180372944051;5501.697406642633;5284.630075894689;5360.3299587551555;5380.677159370412;5412.783488660449;5416.187571864212;5844.941550584483;6030.517558595302;6058.333583305833;6087.604305720114;6091.0863370494335;6156.045812899008;6200.224971878515;6206.069089636546;6244.157038799749;6286.057091436275;6346.365363463663;6370.458511026568;6380.138681278015;6386.201724784402;6394.360563943615;6092.695365231765;6133.26400831903;6147.600405973642;6149.5080393568405;6153.415425534612;6218.067289906459;6257.155284036597;6314.4317011468265;6324.810255692337;6367.808965731036;5738.766165274486;5819.941800582024;6209.720562574695;6254.843628909222;6290.276618188876;5259.65812222212;5569.969555632221;6050.54620903434;6341.239051313872;6384.48924086072;6209.59637623553;6213.440790328892;6237.937620623827;6246.843828904313;6288.025356069817;5767.307923049261;5791;6250.312465628777;6295.496360291166;6312.431881130628;5096.9490305097215;5104.540591346797;5106.795728170831;5109.233614957786;5113.897722045538;4105.3020986432375;4357.586029327209;4499.235130027903;4602.493725690171;4622.6301895848255;5968.910466343008;6018.00702884028;6100.145979562864;6117.188044311255;6133.417325354084;6325.367463253638;6348.920683483819;6362.459190968727;6397.424231819158;6408.67956602168;5878.294604647384;5958.493528050078;6008.519318454513;6078.969605151946;6104.992676208376;5582.106862901916;5591.329040515164;5598.2442370280305;5606.971965140148;5636.689982051026;6505.154329937172;6529.183852018497;6536.215654121535;6540.313267107075;6545.181852268466;6133.73253493014;6203.720832562636;6263;6272.749090036347;6358;6513.772017979348;6523.151990241238;6530.183727034121;6561.212654481493;6567.146270984741;6296.811095667137;6321.936780632319;6336.366363363627;6348.682565871595;6354.777582784581;4967.428745694291;5197.636165468381;6165.506759459322;6261.405166509175;6376.39424254695;6165.876682466415;6222.160008398808;6255.843603909939;6272.839524687947;6297.4647154992335;6200.937990620036;6215.627062376272;6217.533684973736;6234.376562343729;6242.500599952084;5349.946500534945;6080.90878636812;6081;6118.449339559461;6165.3526379731275;5882.646991192136;6191.4118158774845;6196.380361963767;6238;6313.305536391085;6214.036824292242;6235.501159907287;6240.251169859646;6245.469135123565;6252.874942501216 07:51:45 INFO - PROCESS | 1715 | |1;ext.html;501.70148761486917;529.5763389288568;542.3843937131355;546.0416968220769;573.0859279449277;27988.999999999975;39904.802855914335;39962.200755984864;40034.599654003454;40143.1971360573;37312.25375492489;38372.04069898254;40750;41332.58667413325;41337.79331103348;9568.18670413014;9783.119519243266;9792;9800.019998000178;9826.361286516389;8432.873506897371;9485.95257023714;9650;9754.658586949457;9769.071938165898;8148.755537333889;9313.813723725556;9719.17387022104;9732;9737.318387712863;9620.278479114095;9681.467519286436;9753.170980466597;9776.951115244377;9796.608135674565;9624.566894489764;9654.613815447374;9664.903350966471;9707.029297070307;9739.805203895954;39699.60300396988;39753.60246397528;39844.80077599623;40045.59954400448;40125.79622611326;3185.394774992744;3405.897823065312;3417.40195465795;3513.7189024878203;3789.5642001169667;28414.57927103657;29298.70701292981;29435.41129177426;29645.851770741225;30404.239894002825;2670;3260.4620237660756;3321.2029113012945;3330.533725278463;3331.217163966466;429162;501780;511272;513478;513984.9999999963;58818.41181588215;58997.82004359889;59430.702846486354;59433.10850337248;59666;59962.40037599568;61165.694171528856;61278.77442451126;61446.69276653678;61453.38546614477;16113.436029739138;16345.427910023092;16354.264058117413;16444;16601.667966640598;12767.744645107232;12806.487740490462;12866.228026318451;12939.611811645666;13023.47906083765;15250.847491525165;15851.445199417965;15901.045937243802;15936.884418090855;15983.680326393407;3328.201231704422;6489.253735820346;7310.488265821447;7374.26257374269;7394.889076663854;882.9117088291248;956.3974695941512;979.153032626787;984.542187882638;1008.2891561449161;29052.41895162085;29971.250718732204;30120.69879301179;30516;30638;929.9116583924516;1053.3995622495258;1055.0399136785488;1105.474899422784;1144.7939370913316;15122.848771512365;15417.691646167013;15647.217639117998;15659.217039147998;15951.20243987796;687727;693871;695656;696327;697623;57721.71139144361;58360;58895.70552147212;58895.70552147298;59032.70483647554;1374.312843578211;1408.4295860176644;1427.3576890399154;1427.750143724844;1436.4828661681786;29393.85303073471;29863.701362986092;30708;30809.075727728203;30934.535981959838;55843.72078139746;56221.8755624877;56612.15081773694;56637.71681141568;56726.43273567376;557312;563082;570356;570363.1481842564;572792;41504;41960.790196050046;42475.15049699051;42482;42894;45124.77437612791;45931.77034114808;46135.307970381145;46493.76753116348;47360.7631961838;34045.78862887591;38349.42475862808;38456.615433845305;38830;39117.608823911396;31080.68919310778;38837.61162388453;38856.222875542895;39945.60054399419;39955.40066898941;37719.622803771614;37777.81111094427;38357;38385.808070959465;38801.6119838798;33446.33107337888;33691.49462758011;34981.47527787136;34984;35008.82495587608;25705.871470642527;26111.608325874746;26135;26185.73814261833;26720.599191011763 07:51:45 INFO - PROCESS | 1715 | |2;jquery.html;383.9865604703836;385.32583867956396;385.50077649443966;392.83697265634754;415.250472896422;19494.51263718406;20450.386488405373;20661.173553057877;20663.690044649324;21445.142194312248;20438.89780551095;20847.583048339024;20864.47838804031;20915.581688366223;21238.36284911455;5564.666120032791;5981.192539007244;6054.212952316193;6104.96947515264;6124.510039196876;5871.941280587203;5940.524758019348;6012.188354572142;6014.8797024059495;6071.423214794588;6119.326874043873;6150.907736383958;6187.535934804908;6249;6262.906056409158;6123.203983482141;6239.188905442286;6318.87362252757;6815.318468153195;6849.794506164823;5149.922751158736;5869.413058694139;6073.0283154695035;6081.969590152021;6085.96538588441;13356.933215333958;13555.52555660557;13754.105983111065;13805.240711760849;13901.374438150206;2295.254042436215;2432.270318904322;2449.6570480132796;2886.2062932693466;3007.969920300791;9974.451405172713;10623;10716.73208169802;15545.766813497807;16245;1900.429871038683;1931.4398824340924;1959.2750682247517;2017.9293724719712;2069.8758074515576;122080.28558429283;122788;130219.69780302265;131008.6899131006;133144.00283995748;11676.299422034705;11915.165938384403;11937.582184623496;11969.22200057011;12226.938865305616;15045.623859403602;15097.943143980036;15109.017913835565;15116.319765610573;15136.54590362291;8814.647414103363;8895.24390426808;8971.05803890595;8978.191962723386;9015.233705135137;8764.649414023495;8765.211130998241;8832.425892316978;8888.466691998501;8941.46351218929;3859.556151042666;4666.603338716247;4674.11191873543;4703.529647035269;4734.55021772931;1989.9303524376867;2016.9193232270839;2036.6334059869366;2057.331367305602;2063.8348932085396;735.6101266328855;911.6399022386253;934.4299977014016;996.7970784566045;1079.400932482464;20824.58350832975;21289.148434062772;21442.142314307253;21622.243221487173;21637.242696505546;923.3628796130648;967.274544091931;972.7519482531909;996.1930836022844;1007.5063219022626;10965.780684386267;11325.433728313552;11351.60269390584;11375.374354410587;12479.251244925334;614923;616148;622814;630568;631405;94017.99999999863;102502.46246306312;127374;128143;139552;962.2830990911815;999.9150072243941;1015.6140666546665;1018.5009345420691;1018.6231094495084;17184.828151718822;17893.836900601418;18875.433736987914;19254.71117933204;19816.90091549533;52140.739296303276;53809;54178.729106354214;54655.72672136614;56405.71797140988;75161.62419187868;75943.62028189824;76944;77244.2275577237;77397.61301193683;8218.096009439076;8296.170382961656;8316.41785075039;8360.581970901552;8401.32789376836;12500.437480313225;12991.350432478528;13139.802902956271;13150.27673477968;13299.46802127904;9894;11172.49723762449;11205.383703896365;11449.141314401286;11467.598634047768;10016.799664006825;10588.417637030037;11044.116470682166;11156.776864462827;11476.540938362372;9236.445813251226;11639.301641901513;11663.59177428786;11733.823992639946;11851.170418070997;8394.24451799341;11882.584109556125;12138.514459421878;12166.878331216574;12226.388680565758;5594.664320140804;5890.823275301748;11238.719032024264;11725;11824.054075673754 07:51:45 INFO - PROCESS | 1715 | |3;mootools.html;1508.6680930195353;1534.4195478656982;1741.3295881085787;1802.252065392862;1898.6962086066233;7812.296893279604;8073.475224110443;8195.795105122368;8650.870236946443;8675.915510561179;8240.505569665824;8462.323014158868;8469.407141500098;8504.872426913602;8518.063013068557;2348.43637526994;2353.670486131943;2375.8455700379504;2390.294863015406;2395.856248625088;2364.172539611131;2429.7813196812285;2443.584590619599;2443.609022556391;2445.963310550343;2367.775061369176;2386.0813586769045;2403.038784486202;2406.831521793475;2412.0231306320966;2351.294611616508;2356.375560476475;2387.283814855545;2388.796952259043;2397.4485868250313;2388.641703744435;2392.7009123859516;2392.820538459605;2421.721502027272;2428.2715185444295;8528.872066919;8531.274841638467;8561.828763424697;8571.528565928871;8640.179182977607;5230.843074707726;5355.250264962909;5386.407495175527;5392.514673679349;5404.1083221268445;3481.0601137692934;3559.94660080099;3567.7324200685052;3591.2458383739445;3652.7808331500196;954.9140577348003;981.1611072532953;1067.925245232834;1075.3977772447377;1118.3010618363523;10984.615538456115;11092.445377731161;11099.38953357565;11106.666799996014;11119.444027798658;4601.5168407317415;4700.482946875841;4774.140654682191;4776.47458779534;4857.708537487762;9564.426134431957;9590.136887680002;9702.417854928726;9712.271579631555;9720.173785228335;4748.833790817304;5268.420473747885;5277.577793776489;5278.9208161877605;5374.274472946102;4232.280512312914;4327.723321620129;4466.3747075409465;4841.806327746851;4925.876853078702;3634.254977729559;3642.125889786485;3758.774473531597;3772.3775577030033;4041.6968727345566;1293.6442478318538;1300.9349532523336;1308.9018323625767;1319.1689235781396;1319.2414361742037;923.612082925173;941.449252187478;943.9339246252696;947.228009172536;965.8068386322764;5744.51171650406;5782.971085144547;5816.534677225812;5963.284405871236;6182.1345011698395;452.96829221954147;456.68260558911237;457.2113104894031;458.9678722489394;463.2911645182876;3944.5463771666628;3983.3029219886403;3987.80060996949;4007.8396864125107;4087.156719287594;9524.666636667684;10019.749506262402;10094.293399462114;10232.334898231591;10285.794284114425;9942.353747006422;9996.800063998679;10157.898421015843;10168.644097456554;10303.175745940307;7824.452288339761;7855.410844186595;7985.880211796828;8035.758927232192;8053.436259461781;5523.7238138093735;5535.0313695104005;5693.829185124453;5737.340205876378;5742.36833948257;8135.552544610104;9145.719599256243;9506.95246523763;9511.524423778921;9527.618895244113;9412.435253884789;9413.388129771543;9526.190273826802;9542.713718588453;9603.9039609603;7129.536580122275;7276.96361518189;7289.927100728924;7379.8155046124275;7389.667464963982;8119.431639785158;8127.390445716713;8184.140665230065;8191.180881912;8198.344132469507;7241.601711905896;7304.452166087671;7389.852202956018;7501.474896757393;7501.549907005598;7159;7244.348008679244;7274.527155734861;7285.744998925013;7296.854062918605;6293.685315734287;6698.464122870256;6822.249552549315;6971.6165610891885;6997.580145191305;4905.926411103765;4984.651074424755;4989.451160372429;5089.898202036013;5140.897182056263;5028.723420211923;5106.540411362995;5139.871503212449;5146.125158723101;5187.351581052369 07:51:45 INFO - PROCESS | 1715 | |4;prototype.html;252.47989142366723;305.1334210841212;315.7237417259898;317.7251677299137;319.29435946558107;5011.423686276079;5011.949880501194;5122.898576805986;5478.876830249799;5558.63702460012;4720.90558188836;5317.893642127165;5497.312835895513;5497.4502549745;5525.4474552544725;4200.579942005798;4234.17433600448;4240.491141063077;4250.426192464009;4253.595908388698;4148.958510414887;4201.306784380588;4207.389928460371;4254.468191476066;4311.439512863323;3067.555204495347;3856.283953640631;4146.434066702634;4188.183304255671;4188.350805625133;3610.4223324268255;3858.672012878909;4155.189738001091;4215.283401821667;4230.746155230696;3356.228067544454;3483.860645574174;3672.878053654399;3688.61269566697;3722.181120153562;5011.972545628138;5215.078400510053;5259.421463638997;5345.919811202835;5348.598855085846;4810.735409552473;4838.540338667821;4860.7326597037145;4873.537013983666;4877.926831097537;5165.19218273605;5766.365699773063;5795.971020144914;5809.564282678816;5824.796132135355;3668.578113516953;3932.154586763831;3944.1717239379764;3949.1509325494867;3962.603739626043;5791.710414479301;6026.945284575182;6095.08573713942;6175.969120154416;6176.263360666821;3982.2433737589763;3998.5601583825755;4011.839526418969;4017.1363156920816;4027.7784721839994;3762.774233545996;4000.179963107556;4042.604212461488;4052.2098190852503;4091;4721.504242054603;4721.5986641135205;4744.691595046311;4759.904801903943;4765.475797662254;5821.621594596338;5829.970850145807;5853.502452291517;5853.88292234153;5889.5877288590245;1159.96520104397;1205.4454950722766;1224.871388504212;1261.438659796382;1306.243103026428;830.4353039932904;862.8101817600118;877.2236570634907;898.2544488075013;905.9129045145851;4164.833846522978;5094.6688465249645;5221.634485586049;5223.686578805208;5283.815066472732;4603.49361570227;5055.519725626134;5392.299001129828;5433.538149257279;5672.659640421505;4380.327999920046;4609.953900460952;4800.783964721596;5188.429272779991;5195;2698.865056747155;2719.279390961397;2770.279727270884;3029.8182109073527;3041;5424;5779.88440231193;5854.385289544622;5966.523892584615;6047.2743270806905;4548.818047278138;5548.334199896039;5590.720463976785;5774.68239246837;5933.436323549256;5137.691738495628;5612.709076912333;5909.763609455659;6026.734385779036;6072.453479186806;4840.838198832184;5045.369328833895;5615.894039735099;5706.543476521785;5775.527240553632;5538.307711536058;5904.911426328695;5980.671063091571;5984.670843103497;6013.699315034143;5743.93737158627;6024.855277497261;6303.842403939938;6314.715837787218;6332.335104814112;3343.8160901150673;3782.583915769208;3987.4218238355857;4001.8799436016966;4018.3369743991916;5758.654480731169;5987.784519727728;6014.428629280212;6023.3374328824675;6036.607620504653;5154.659788455104;5208.661437006583;5713.143028545752;5802.738876750472;5823.242978412779;5082.957993611227;5798.884022319446;5842.883142337215;5866.472017518444;5875.236219291465;4974.801007959786;5177.715225662625;5487.5884308677805;5709.486146246858;5769.817187476473;4411.434165638549;5871.94128058714;5948.5538584605465;5956.5532585055425;5960.155699573837;5458.77177635029;5532.336119665666;5722.656640601577;5741.578984182072;5827.572244799881 07:51:45 INFO - PROCESS | 1715 | |5;yui.html;725.6009194942782;726.2737262737263;739.2422766664168;759.9354054905333;783.6434422337837;14758.409663613456;15826.841731582696;16569.25438355274;17021.97868127913;17197.312107515714;15896.761548576751;15962.920185399056;16277.430289939855;16288.918555407236;16521.00873947564;838.6268110690745;856.387682806793;856.8714692796068;857.789841488833;858.3991206155684;853.9871901921476;876.3952872517942;879.3844308983705;881.775147337428;896.1979028769248;890.9198172164504;893.0266010049045;926.5182105305237;930.2557953637097;930.6044930904338;882.7925437522177;895.7044175422128;900.2527901841456;919.8252332056887;920.9907900920972;659.5712786688642;681.5467713970204;681.8363592737708;684.4626967830279;687.8658661560997;14709;15018.549443516602;15023.849761502464;15247.313870875727;15442.691146177125;13784.655383615489;13967.511137110254;14025.228612426312;14128;14229.857701422958;11543.711407214803;11683.123765717604;11877.524899004029;11906.404679765978;12021.93989030058;3418.7265018798685;3704.3887758519813;3720.813959302024;3766.190269092131;3802.040239993263;96092;96981.5452768209;97256;99850.50074749652;100105;10532.526036328383;10789.46052697362;10824.837627435594;10916.836247456295;10925.672229833117;20011.399658010283;20790;20809.687854682194;20812.791872081085;21103.577928441344;6965.756198533129;7022.54353467023;7030.929690703129;7168.319009694071;7197.064381630459;3872.3997780344093;3947.407888816643;3961.980190099031;3964.960350396517;4002.139539998856;3410.9488357674654;3448;3501.702355299777;3508.1054331145397;3527.5943266524164;648.5946283572767;649.8732747114362;656.6847913001691;662.4170729757782;673.4309508465338;577.413924866261;599.5563283170422;623.4233334165879;669.9832504187434;673.7204060315013;8718.168755488115;9293.58178881952;9469.526523673789;9905.504724763732;10085.142762865238;551.8796546301535;636.8759140117696;642.2325321241073;677.7309883576913;689.5070024932097;4174.874753757392;4578.954210457853;4610.492845786961;4628.83799067031;4640.976795116003;111176.88823111827;111376;111405;113161;115650.42174789072;95886.52056739671;96194;98195;98420;99905.0018999616;64610.67694661591;78457.82313265305;80581.17965871283;85788.57105714432;89272;8439.451435656663;8689.348298877483;8726.127387261224;8959.820803583762;8973.05782892787;45482;54215.72892135514;55151.724241378535;56732.716336419704;56816;68295.63408731896;68327.97508037483;72774.63612681902;73043.63478182575;73711;11681.299122052704;12558.811617825557;12593.559225427067;12753.872461275269;13378.799318010042;14240;14761.55715328542;14837.961342705907;14995.400183992955;15233.162176079979;13212.273324966834;13401.128926619738;13951.302434878013;14046.859531404556;14081.15513069178;13599.320033998063;13600.97992650575;13742.312884355542;13798.448062077807;13874.861251387358;12977.351132443151;13328.40022198984;13497.595072147851;13499.527516536875;13606.86393136056;9644.75888102803;10767.407792571485;11014.39420831862;11029.669109926715;11078.279911805706;11194.66416007521;11456.541738330374;11691;11716.70708232301;11719.824202636797 07:51:45 INFO - PROCESS | 1715 | __end_tp_report 07:51:45 INFO - PROCESS | 1715 | __start_cc_report 07:51:45 INFO - PROCESS | 1715 | _x_x_mozilla_cycle_collect,359 07:51:45 INFO - PROCESS | 1715 | __end_cc_report 07:51:45 INFO - PROCESS | 1715 | __startTimestamp1486137105028__endTimestamp 07:51:45 INFO - PROCESS | 1715 | 07:51:45 INFO - PROCESS | 1715 | ------- Summary: start ------- 07:51:45 INFO - PROCESS | 1715 | Number of tests: 6 07:51:45 INFO - PROCESS | 1715 | 07:51:45 INFO - PROCESS | 1715 | [#0] dojo.html Cycles:165 Average:5865.61 Median:6117.19 stddev:634.91 (10.4%) stddev-sans-first:610.59 07:51:45 INFO - PROCESS | 1715 | Values: 3561.8 3565.2 3594.3 3607.9 3632.0 5959.0 5975.8 5988.9 6011.3 6022.1 5931.1 6006.5 6030.1 6049.9 6078.1 5261.5 5388.0 5388.4 5397.8 5474.0 4535.4 5123.9 5450.0 5462.2 5464.3 5280.1 5304.2 5335.6 5437.9 5457.9 5375.4 5377.2 5419.9 5464.2 5501.7 5284.6 5360.3 5380.7 5412.8 5416.2 5844.9 6030.5 6058.3 6087.6 6091.1 6156.0 6200.2 6206.1 6244.2 6286.1 6346.4 6370.5 6380.1 6386.2 6394.4 6092.7 6133.3 6147.6 6149.5 6153.4 6218.1 6257.2 6314.4 6324.8 6367.8 5738.8 5819.9 6209.7 6254.8 6290.3 5259.7 5570.0 6050.5 6341.2 6384.5 6209.6 6213.4 6237.9 6246.8 6288.0 5767.3 5791.0 6250.3 6295.5 6312.4 5096.9 5104.5 5106.8 5109.2 5113.9 4105.3 4357.6 4499.2 4602.5 4622.6 5968.9 6018.0 6100.1 6117.2 6133.4 6325.4 6348.9 6362.5 6397.4 6408.7 5878.3 5958.5 6008.5 6079.0 6105.0 5582.1 5591.3 5598.2 5607.0 5636.7 6505.2 6529.2 6536.2 6540.3 6545.2 6133.7 6203.7 6263.0 6272.7 6358.0 6513.8 6523.2 6530.2 6561.2 6567.1 6296.8 6321.9 6336.4 6348.7 6354.8 4967.4 5197.6 6165.5 6261.4 6376.4 6165.9 6222.2 6255.8 6272.8 6297.5 6200.9 6215.6 6217.5 6234.4 6242.5 5349.9 6080.9 6081.0 6118.4 6165.4 5882.6 6191.4 6196.4 6238.0 6313.3 6214.0 6235.5 6240.3 6245.5 6252.9 07:51:45 INFO - PROCESS | 1715 | 07:51:45 INFO - PROCESS | 1715 | [#1] ext.html Cycles:180 Average:71825.32 Median:40085.70 stddev:158141.66 (394.5%) stddev-sans-first:158494.62 07:51:45 INFO - PROCESS | 1715 | Values: 501.7 529.6 542.4 546.0 573.1 27989.0 39904.8 39962.2 40034.6 40143.2 37312.3 38372.0 40750.0 41332.6 41337.8 9568.2 9783.1 9792.0 9800.0 9826.4 8432.9 9486.0 9650.0 9754.7 9769.1 8148.8 9313.8 9719.2 9732.0 9737.3 9620.3 9681.5 9753.2 9777.0 9796.6 9624.6 9654.6 9664.9 9707.0 9739.8 39699.6 39753.6 39844.8 40045.6 40125.8 3185.4 3405.9 3417.4 3513.7 3789.6 28414.6 29298.7 29435.4 29645.9 30404.2 2670.0 3260.5 3321.2 3330.5 3331.2 429162.0 501780.0 511272.0 513478.0 513985.0 58818.4 58997.8 59430.7 59433.1 59666.0 59962.4 61165.7 61278.8 61446.7 61453.4 16113.4 16345.4 16354.3 16444.0 16601.7 12767.7 12806.5 12866.2 12939.6 13023.5 15250.8 15851.4 15901.0 15936.9 15983.7 3328.2 6489.3 7310.5 7374.3 7394.9 882.9 956.4 979.2 984.5 1008.3 29052.4 29971.3 30120.7 30516.0 30638.0 929.9 1053.4 1055.0 1105.5 1144.8 15122.8 15417.7 15647.2 15659.2 15951.2 687727.0 693871.0 695656.0 696327.0 697623.0 57721.7 58360.0 58895.7 58895.7 59032.7 1374.3 1408.4 1427.4 1427.8 1436.5 29393.9 29863.7 30708.0 30809.1 30934.5 55843.7 56221.9 56612.2 56637.7 56726.4 557312.0 563082.0 570356.0 570363.1 572792.0 41504.0 41960.8 42475.2 42482.0 42894.0 45124.8 45931.8 46135.3 46493.8 47360.8 34045.8 38349.4 38456.6 38830.0 39117.6 31080.7 38837.6 38856.2 39945.6 39955.4 37719.6 37777.8 38357.0 38385.8 38801.6 33446.3 33691.5 34981.5 34984.0 35008.8 25705.9 26111.6 26135.0 26185.7 26720.6 07:51:45 INFO - PROCESS | 1715 | 07:51:45 INFO - PROCESS | 1715 | [#2] jquery.html Cycles:180 Average:35669.04 Median:21533.69 stddev:103807.66 (482.1%) stddev-sans-first:104065.05 07:51:45 INFO - PROCESS | 1715 | Values: 384.0 385.3 385.5 392.8 415.3 19494.5 20450.4 20661.2 20663.7 21445.1 20438.9 20847.6 20864.5 20915.6 21238.4 5564.7 5981.2 6054.2 6105.0 6124.5 5871.9 5940.5 6012.2 6014.9 6071.4 6119.3 6150.9 6187.5 6249.0 6262.9 6123.2 6239.2 6318.9 6815.3 6849.8 5149.9 5869.4 6073.0 6082.0 6086.0 13356.9 13555.5 13754.1 13805.2 13901.4 2295.3 2432.3 2449.7 2886.2 3008.0 9974.5 10623.0 10716.7 15545.8 16245.0 1900.4 1931.4 1959.3 2017.9 2069.9 122080.3 122788.0 130219.7 131008.7 133144.0 11676.3 11915.2 11937.6 11969.2 12226.9 15045.6 15097.9 15109.0 15116.3 15136.5 8814.6 8895.2 8971.1 8978.2 9015.2 8764.6 8765.2 8832.4 8888.5 8941.5 3859.6 4666.6 4674.1 4703.5 4734.6 1989.9 2016.9 2036.6 2057.3 2063.8 735.6 911.6 934.4 996.8 1079.4 20824.6 21289.1 21442.1 21622.2 21637.2 923.4 967.3 972.8 996.2 1007.5 10965.8 11325.4 11351.6 11375.4 12479.3 614923.0 616148.0 622814.0 630568.0 631405.0 94018.0 102502.5 127374.0 128143.0 139552.0 962.3 999.9 1015.6 1018.5 1018.6 17184.8 17893.8 18875.4 19254.7 19816.9 52140.7 53809.0 54178.7 54655.7 56405.7 75161.6 75943.6 76944.0 77244.2 77397.6 8218.1 8296.2 8316.4 8360.6 8401.3 12500.4 12991.4 13139.8 13150.3 13299.5 9894.0 11172.5 11205.4 11449.1 11467.6 10016.8 10588.4 11044.1 11156.8 11476.5 9236.4 11639.3 11663.6 11733.8 11851.2 8394.2 11882.6 12138.5 12166.9 12226.4 5594.7 5890.8 11238.7 11725.0 11824.1 07:51:45 INFO - PROCESS | 1715 | 07:51:45 INFO - PROCESS | 1715 | [#3] mootools.html Cycles:180 Average:5553.83 Median:5209.10 stddev:3027.56 (58.1%) stddev-sans-first:3020.79 07:51:45 INFO - PROCESS | 1715 | Values: 1508.7 1534.4 1741.3 1802.3 1898.7 7812.3 8073.5 8195.8 8650.9 8675.9 8240.5 8462.3 8469.4 8504.9 8518.1 2348.4 2353.7 2375.8 2390.3 2395.9 2364.2 2429.8 2443.6 2443.6 2446.0 2367.8 2386.1 2403.0 2406.8 2412.0 2351.3 2356.4 2387.3 2388.8 2397.4 2388.6 2392.7 2392.8 2421.7 2428.3 8528.9 8531.3 8561.8 8571.5 8640.2 5230.8 5355.3 5386.4 5392.5 5404.1 3481.1 3559.9 3567.7 3591.2 3652.8 954.9 981.2 1067.9 1075.4 1118.3 10984.6 11092.4 11099.4 11106.7 11119.4 4601.5 4700.5 4774.1 4776.5 4857.7 9564.4 9590.1 9702.4 9712.3 9720.2 4748.8 5268.4 5277.6 5278.9 5374.3 4232.3 4327.7 4466.4 4841.8 4925.9 3634.3 3642.1 3758.8 3772.4 4041.7 1293.6 1300.9 1308.9 1319.2 1319.2 923.6 941.4 943.9 947.2 965.8 5744.5 5783.0 5816.5 5963.3 6182.1 453.0 456.7 457.2 459.0 463.3 3944.5 3983.3 3987.8 4007.8 4087.2 9524.7 10019.7 10094.3 10232.3 10285.8 9942.4 9996.8 10157.9 10168.6 10303.2 7824.5 7855.4 7985.9 8035.8 8053.4 5523.7 5535.0 5693.8 5737.3 5742.4 8135.6 9145.7 9507.0 9511.5 9527.6 9412.4 9413.4 9526.2 9542.7 9603.9 7129.5 7277.0 7289.9 7379.8 7389.7 8119.4 8127.4 8184.1 8191.2 8198.3 7241.6 7304.5 7389.9 7501.5 7501.5 7159.0 7244.3 7274.5 7285.7 7296.9 6293.7 6698.5 6822.2 6971.6 6997.6 4905.9 4984.7 4989.5 5089.9 5140.9 5028.7 5106.5 5139.9 5146.1 5187.4 07:51:45 INFO - PROCESS | 1715 | 07:51:45 INFO - PROCESS | 1715 | [#4] prototype.html Cycles:180 Average:4647.85 Median:5171.45 stddev:1446.23 (28.0%) stddev-sans-first:1412.16 07:51:45 INFO - PROCESS | 1715 | Values: 252.5 305.1 315.7 317.7 319.3 5011.4 5011.9 5122.9 5478.9 5558.6 4720.9 5317.9 5497.3 5497.5 5525.4 4200.6 4234.2 4240.5 4250.4 4253.6 4149.0 4201.3 4207.4 4254.5 4311.4 3067.6 3856.3 4146.4 4188.2 4188.4 3610.4 3858.7 4155.2 4215.3 4230.7 3356.2 3483.9 3672.9 3688.6 3722.2 5012.0 5215.1 5259.4 5345.9 5348.6 4810.7 4838.5 4860.7 4873.5 4877.9 5165.2 5766.4 5796.0 5809.6 5824.8 3668.6 3932.2 3944.2 3949.2 3962.6 5791.7 6026.9 6095.1 6176.0 6176.3 3982.2 3998.6 4011.8 4017.1 4027.8 3762.8 4000.2 4042.6 4052.2 4091.0 4721.5 4721.6 4744.7 4759.9 4765.5 5821.6 5830.0 5853.5 5853.9 5889.6 1160.0 1205.4 1224.9 1261.4 1306.2 830.4 862.8 877.2 898.3 905.9 4164.8 5094.7 5221.6 5223.7 5283.8 4603.5 5055.5 5392.3 5433.5 5672.7 4380.3 4610.0 4800.8 5188.4 5195.0 2698.9 2719.3 2770.3 3029.8 3041.0 5424.0 5779.9 5854.4 5966.5 6047.3 4548.8 5548.3 5590.7 5774.7 5933.4 5137.7 5612.7 5909.8 6026.7 6072.5 4840.8 5045.4 5615.9 5706.5 5775.5 5538.3 5904.9 5980.7 5984.7 6013.7 5743.9 6024.9 6303.8 6314.7 6332.3 3343.8 3782.6 3987.4 4001.9 4018.3 5758.7 5987.8 6014.4 6023.3 6036.6 5154.7 5208.7 5713.1 5802.7 5823.2 5083.0 5798.9 5842.9 5866.5 5875.2 4974.8 5177.7 5487.6 5709.5 5769.8 4411.4 5871.9 5948.6 5956.6 5960.2 5458.8 5532.3 5722.7 5741.6 5827.6 07:51:45 INFO - PROCESS | 1715 | 07:51:45 INFO - PROCESS | 1715 | [#5] yui.html Cycles:180 Average:21007.08 Median:4088.51 stddev:30575.53 (747.8%) stddev-sans-first:30623.38 07:51:45 INFO - PROCESS | 1715 | Values: 725.6 726.3 739.2 759.9 783.6 14758.4 15826.8 16569.3 17022.0 17197.3 15896.8 15962.9 16277.4 16288.9 16521.0 838.6 856.4 856.9 857.8 858.4 854.0 876.4 879.4 881.8 896.2 890.9 893.0 926.5 930.3 930.6 882.8 895.7 900.3 919.8 921.0 659.6 681.5 681.8 684.5 687.9 14709.0 15018.5 15023.8 15247.3 15442.7 13784.7 13967.5 14025.2 14128.0 14229.9 11543.7 11683.1 11877.5 11906.4 12021.9 3418.7 3704.4 3720.8 3766.2 3802.0 96092.0 96981.5 97256.0 99850.5 100105.0 10532.5 10789.5 10824.8 10916.8 10925.7 20011.4 20790.0 20809.7 20812.8 21103.6 6965.8 7022.5 7030.9 7168.3 7197.1 3872.4 3947.4 3962.0 3965.0 4002.1 3410.9 3448.0 3501.7 3508.1 3527.6 648.6 649.9 656.7 662.4 673.4 577.4 599.6 623.4 670.0 673.7 8718.2 9293.6 9469.5 9905.5 10085.1 551.9 636.9 642.2 677.7 689.5 4174.9 4579.0 4610.5 4628.8 4641.0 111176.9 111376.0 111405.0 113161.0 115650.4 95886.5 96194.0 98195.0 98420.0 99905.0 64610.7 78457.8 80581.2 85788.6 89272.0 8439.5 8689.3 8726.1 8959.8 8973.1 45482.0 54215.7 55151.7 56732.7 56816.0 68295.6 68328.0 72774.6 73043.6 73711.0 11681.3 12558.8 12593.6 12753.9 13378.8 14240.0 14761.6 14838.0 14995.4 15233.2 13212.3 13401.1 13951.3 14046.9 14081.2 13599.3 13601.0 13742.3 13798.4 13874.9 12977.4 13328.4 13497.6 13499.5 13606.9 9644.8 10767.4 11014.4 11029.7 11078.3 11194.7 11456.5 11691.0 11716.7 11719.8 07:51:45 INFO - PROCESS | 1715 | -------- Summary: end -------- 07:51:45 INFO - PROCESS | 1715 | 07:51:45 INFO - TEST-INFO | 1715: exit 0 07:51:45 INFO - TEST-OK | dromaeo_css | took 1115000ms 07:51:45 INFO - TEST-START | kraken 07:51:45 INFO - operating with platform_type : mac_ 07:51:45 INFO - Initialising browser for kraken test... 07:51:45 INFO - TEST-INFO | started process 1832 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpx8WSMM/profile http://localhost:49236/getInfo.html) 07:51:48 INFO - PROCESS | 1832 | 2017-02-03 07:51:48.220 plugin-container[1835:10511] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8537, name = 'com.apple.tsm.portname' 07:51:48 INFO - PROCESS | 1832 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:51:48 INFO - PROCESS | 1832 | 2017-02-03 07:51:48.221 plugin-container[1835:10511] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x865b, name = 'com.apple.CFPasteboardClient' 07:51:48 INFO - PROCESS | 1832 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:51:48 INFO - PROCESS | 1832 | 2017-02-03 07:51:48.221 plugin-container[1835:10511] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:51:48 INFO - PROCESS | 1832 | __metrics Screen width/height:1600/1200 07:51:48 INFO - PROCESS | 1832 | colorDepth:24 07:51:48 INFO - PROCESS | 1832 | Browser inner width/height: 1024/689 07:51:48 INFO - PROCESS | 1832 | __metrics 07:51:48 ERROR - PROCESS | 1832 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 07:51:49 INFO - TEST-INFO | 1832: exit 0 07:51:49 INFO - Browser initialized. 07:51:49 INFO - Running cycle 1/1 for kraken test... 07:51:49 INFO - TEST-INFO | started process 1836 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpx8WSMM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:51:51 INFO - PROCESS | 1836 | 2017-02-03 07:51:51.614 plugin-container[1837:10635] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x823f, name = 'com.apple.tsm.portname' 07:51:51 INFO - PROCESS | 1836 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:51:51 INFO - PROCESS | 1836 | 2017-02-03 07:51:51.614 plugin-container[1837:10635] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451b, name = 'com.apple.CFPasteboardClient' 07:51:51 INFO - PROCESS | 1836 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:51:51 INFO - PROCESS | 1836 | 2017-02-03 07:51:51.614 plugin-container[1837:10635] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:52:01 INFO - PROCESS | 1836 | RSS: Main: 177332224 07:52:01 INFO - PROCESS | 1836 | 07:52:04 INFO - PROCESS | 1836 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 07:52:05 INFO - PROCESS | 1836 | RSS: Main: 190312448 07:52:05 INFO - PROCESS | 1836 | 07:52:07 INFO - PROCESS | 1836 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 07:52:08 INFO - PROCESS | 1836 | RSS: Main: 198201344 07:52:08 INFO - PROCESS | 1836 | 07:52:11 INFO - PROCESS | 1836 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 07:52:12 INFO - PROCESS | 1836 | RSS: Main: 201859072 07:52:12 INFO - PROCESS | 1836 | 07:52:13 INFO - PROCESS | 1836 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 07:52:14 INFO - PROCESS | 1836 | RSS: Main: 202870784 07:52:14 INFO - PROCESS | 1836 | 07:52:16 INFO - PROCESS | 1836 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:52:16 INFO - PROCESS | 1836 | RSS: Main: 203034624 07:52:16 INFO - PROCESS | 1836 | 07:52:19 INFO - PROCESS | 1836 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 07:52:20 INFO - PROCESS | 1836 | RSS: Main: 207470592 07:52:20 INFO - PROCESS | 1836 | 07:52:23 INFO - PROCESS | 1836 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 07:52:24 INFO - PROCESS | 1836 | RSS: Main: 207523840 07:52:24 INFO - PROCESS | 1836 | 07:52:27 INFO - PROCESS | 1836 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 07:52:27 INFO - PROCESS | 1836 | RSS: Main: 207024128 07:52:27 INFO - PROCESS | 1836 | 07:52:29 INFO - PROCESS | 1836 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:52:29 INFO - PROCESS | 1836 | RSS: Main: 206196736 07:52:29 INFO - PROCESS | 1836 | 07:52:32 INFO - PROCESS | 1836 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:52:32 INFO - PROCESS | 1836 | RSS: Main: 206274560 07:52:32 INFO - PROCESS | 1836 | 07:52:34 INFO - PROCESS | 1836 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:52:35 INFO - PROCESS | 1836 | RSS: Main: 206684160 07:52:35 INFO - PROCESS | 1836 | 07:52:38 INFO - PROCESS | 1836 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:52:39 INFO - PROCESS | 1836 | RSS: Main: 206733312 07:52:39 INFO - PROCESS | 1836 | 07:52:41 INFO - PROCESS | 1836 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:52:42 INFO - PROCESS | 1836 | RSS: Main: 207155200 07:52:42 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 07:52:44 INFO - PROCESS | 1836 | RSS: Main: 208273408 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | __start_tp_report 07:52:44 INFO - PROCESS | 1836 | _x_x_mozilla_page_load 07:52:44 INFO - PROCESS | 1836 | _x_x_mozilla_page_load_details 07:52:44 INFO - PROCESS | 1836 | |i|pagename|runs| 07:52:44 INFO - PROCESS | 1836 | |0;ai-astar;105;118;116;115;113;116;117;116;115;115 07:52:44 INFO - PROCESS | 1836 | |1;audio-beat-detection;142;107;110;141;126;133;109;112;134;104 07:52:44 INFO - PROCESS | 1836 | |2;audio-dft;193;199;195;200;195;192;196;200;204;186 07:52:44 INFO - PROCESS | 1836 | |3;audio-fft;83;59;60;86;63;62;60;63;77;58 07:52:44 INFO - PROCESS | 1836 | |4;audio-oscillator;88;71;90;72;71;69;83;68;71;89 07:52:44 INFO - PROCESS | 1836 | |5;imaging-gaussian-blur;135;117;90;93;134;86;92;87;102;135 07:52:44 INFO - PROCESS | 1836 | |6;imaging-darkroom;149;87;147;150;94;94;98;104;147;97 07:52:44 INFO - PROCESS | 1836 | |7;imaging-desaturate;140;141;86;87;95;87;91;89;89;91 07:52:44 INFO - PROCESS | 1836 | |8;json-parse-financial;57;55;55;57;58;59;59;59;60;60 07:52:44 INFO - PROCESS | 1836 | |9;json-stringify-tinderbox;55;90;102;70;97;105;96;89;69;68 07:52:44 INFO - PROCESS | 1836 | |10;stanford-crypto-aes;83;80;84;104;104;83;87;89;83;83 07:52:44 INFO - PROCESS | 1836 | |11;stanford-crypto-ccm;135;139;137;138;144;139;142;173;183;152 07:52:44 INFO - PROCESS | 1836 | |12;stanford-crypto-pbkdf2;165;167;164;166;166;167;171;192;226;177 07:52:44 INFO - PROCESS | 1836 | |13;stanford-crypto-sha256-iterative;68;68;65;66;66;65;65;66;68;72 07:52:44 INFO - PROCESS | 1836 | __end_tp_report 07:52:44 INFO - PROCESS | 1836 | __start_cc_report 07:52:44 INFO - PROCESS | 1836 | _x_x_mozilla_cycle_collect,899 07:52:44 INFO - PROCESS | 1836 | __end_cc_report 07:52:44 INFO - PROCESS | 1836 | __startTimestamp1486137164436__endTimestamp 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | ------- Summary: start ------- 07:52:44 INFO - PROCESS | 1836 | Number of tests: 14 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | [#0] ai-astar Cycles:10 Average:114.60 Median:116.00 stddev:3.63 (3.1%) stddev-sans-first:1.41 07:52:44 INFO - PROCESS | 1836 | Values: 105.0 118.0 116.0 115.0 113.0 116.0 117.0 116.0 115.0 115.0 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | [#1] audio-beat-detection Cycles:10 Average:121.80 Median:129.50 stddev:14.92 (11.5%) stddev-sans-first:13.92 07:52:44 INFO - PROCESS | 1836 | Values: 142.0 107.0 110.0 141.0 126.0 133.0 109.0 112.0 134.0 104.0 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | [#2] audio-dft Cycles:10 Average:196.00 Median:197.50 stddev:5.08 (2.6%) stddev-sans-first:5.27 07:52:44 INFO - PROCESS | 1836 | Values: 193.0 199.0 195.0 200.0 195.0 192.0 196.0 200.0 204.0 186.0 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | [#3] audio-fft Cycles:10 Average:67.10 Median:63.00 stddev:10.63 (16.9%) stddev-sans-first:9.59 07:52:44 INFO - PROCESS | 1836 | Values: 83.0 59.0 60.0 86.0 63.0 62.0 60.0 63.0 77.0 58.0 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:77.50 stddev:9.11 (11.8%) stddev-sans-first:8.79 07:52:44 INFO - PROCESS | 1836 | Values: 88.0 71.0 90.0 72.0 71.0 69.0 83.0 68.0 71.0 89.0 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | [#5] imaging-gaussian-blur Cycles:10 Average:107.10 Median:86.50 stddev:21.01 (24.3%) stddev-sans-first:19.71 07:52:44 INFO - PROCESS | 1836 | Values: 135.0 117.0 90.0 93.0 134.0 86.0 92.0 87.0 102.0 135.0 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | [#6] imaging-darkroom Cycles:10 Average:116.70 Median:90.50 stddev:27.49 (30.4%) stddev-sans-first:26.55 07:52:44 INFO - PROCESS | 1836 | Values: 149.0 87.0 147.0 150.0 94.0 94.0 98.0 104.0 147.0 97.0 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | [#7] imaging-desaturate Cycles:10 Average:99.60 Median:89.00 stddev:21.71 (24.4%) stddev-sans-first:17.42 07:52:44 INFO - PROCESS | 1836 | Values: 140.0 141.0 86.0 87.0 95.0 87.0 91.0 89.0 89.0 91.0 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:59.00 stddev:1.85 (3.1%) stddev-sans-first:1.94 07:52:44 INFO - PROCESS | 1836 | Values: 57.0 55.0 55.0 57.0 58.0 59.0 59.0 59.0 60.0 60.0 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | [#9] json-stringify-tinderbox Cycles:10 Average:84.10 Median:79.50 stddev:17.18 (21.6%) stddev-sans-first:14.65 07:52:44 INFO - PROCESS | 1836 | Values: 55.0 90.0 102.0 70.0 97.0 105.0 96.0 89.0 69.0 68.0 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:83.00 stddev:8.78 (10.6%) stddev-sans-first:9.13 07:52:44 INFO - PROCESS | 1836 | Values: 83.0 80.0 84.0 104.0 104.0 83.0 87.0 89.0 83.0 83.0 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:143.00 stddev:16.57 (11.6%) stddev-sans-first:16.87 07:52:44 INFO - PROCESS | 1836 | Values: 135.0 139.0 137.0 138.0 144.0 139.0 142.0 173.0 183.0 152.0 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:169.00 stddev:19.46 (11.5%) stddev-sans-first:20.22 07:52:44 INFO - PROCESS | 1836 | Values: 165.0 167.0 164.0 166.0 166.0 167.0 171.0 192.0 226.0 177.0 07:52:44 INFO - PROCESS | 1836 | 07:52:44 INFO - PROCESS | 1836 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:2.18 (3.3%) stddev-sans-first:2.28 07:52:44 INFO - PROCESS | 1836 | Values: 68.0 68.0 65.0 66.0 66.0 65.0 65.0 66.0 68.0 72.0 07:52:44 INFO - PROCESS | 1836 | -------- Summary: end -------- 07:52:44 INFO - PROCESS | 1836 | 07:52:45 INFO - TEST-INFO | 1836: exit 0 07:52:45 INFO - TEST-OK | kraken | took 59957ms 07:52:45 INFO - SUITE-END | took 1174s 07:52:45 INFO - Completed test suite (00:19:35) 07:52:45 INFO - javascript benchmark 07:52:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7361.185753202267, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3561.76848504847, 3565.233474802917, 3594.2631760489094, 3607.9458808117865, 3632.019354774209, 5959.0, 5975.790847320339, 5988.910166347503, 6011.338752737206, 6022.126791615213, 5931.110333449985, 6006.45941865232, 6030.125631783389, 6049.941260279445, 6078.088286756989, 5261.473852614737, 5387.973060134694, 5388.407275199725, 5397.8380648580605, 5474.0, 4535.387722657432, 5123.871903202413, 5450.0, 5462.20797984292, 5464.26232458619, 5280.128778751501, 5304.177852432879, 5335.599830012745, 5437.945620543804, 5457.945420545783, 5375.354957405137, 5377.166539186433, 5419.891602167974, 5464.180372944051, 5501.697406642633, 5284.630075894689, 5360.3299587551555, 5380.677159370412, 5412.783488660449, 5416.187571864212, 5844.941550584483, 6030.517558595302, 6058.333583305833, 6087.604305720114, 6091.0863370494335, 6156.045812899008, 6200.224971878515, 6206.069089636546, 6244.157038799749, 6286.057091436275, 6346.365363463663, 6370.458511026568, 6380.138681278015, 6386.201724784402, 6394.360563943615, 6092.695365231765, 6133.26400831903, 6147.600405973642, 6149.5080393568405, 6153.415425534612, 6218.067289906459, 6257.155284036597, 6314.4317011468265, 6324.810255692337, 6367.808965731036, 5738.766165274486, 5819.941800582024, 6209.720562574695, 6254.843628909222, 6290.276618188876, 5259.65812222212, 5569.969555632221, 6050.54620903434, 6341.239051313872, 6384.48924086072, 6209.59637623553, 6213.440790328892, 6237.937620623827, 6246.843828904313, 6288.025356069817, 5767.307923049261, 5791.0, 6250.312465628777, 6295.496360291166, 6312.431881130628, 5096.9490305097215, 5104.540591346797, 5106.795728170831, 5109.233614957786, 5113.897722045538, 4105.3020986432375, 4357.586029327209, 4499.235130027903, 4602.493725690171, 4622.6301895848255, 5968.910466343008, 6018.00702884028, 6100.145979562864, 6117.188044311255, 6133.417325354084, 6325.367463253638, 6348.920683483819, 6362.459190968727, 6397.424231819158, 6408.67956602168, 5878.294604647384, 5958.493528050078, 6008.519318454513, 6078.969605151946, 6104.992676208376, 5582.106862901916, 5591.329040515164, 5598.2442370280305, 5606.971965140148, 5636.689982051026, 6505.154329937172, 6529.183852018497, 6536.215654121535, 6540.313267107075, 6545.181852268466, 6133.73253493014, 6203.720832562636, 6263.0, 6272.749090036347, 6358.0, 6513.772017979348, 6523.151990241238, 6530.183727034121, 6561.212654481493, 6567.146270984741, 6296.811095667137, 6321.936780632319, 6336.366363363627, 6348.682565871595, 6354.777582784581, 4967.428745694291, 5197.636165468381, 6165.506759459322, 6261.405166509175, 6376.39424254695, 6165.876682466415, 6222.160008398808, 6255.843603909939, 6272.839524687947, 6297.4647154992335, 6200.937990620036, 6215.627062376272, 6217.533684973736, 6234.376562343729, 6242.500599952084, 5349.946500534945, 6080.90878636812, 6081.0, 6118.449339559461, 6165.3526379731275, 5882.646991192136, 6191.4118158774845, 6196.380361963767, 6238.0, 6313.305536391085, 6214.036824292242, 6235.501159907287, 6240.251169859646, 6245.469135123565, 6252.874942501216], "value": 5828.199603909074, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.70148761486917, 529.5763389288568, 542.3843937131355, 546.0416968220769, 573.0859279449277, 27988.999999999975, 39904.802855914335, 39962.200755984864, 40034.599654003454, 40143.1971360573, 37312.25375492489, 38372.04069898254, 40750.0, 41332.58667413325, 41337.79331103348, 9568.18670413014, 9783.119519243266, 9792.0, 9800.019998000178, 9826.361286516389, 8432.873506897371, 9485.95257023714, 9650.0, 9754.658586949457, 9769.071938165898, 8148.755537333889, 9313.813723725556, 9719.17387022104, 9732.0, 9737.318387712863, 9620.278479114095, 9681.467519286436, 9753.170980466597, 9776.951115244377, 9796.608135674565, 9624.566894489764, 9654.613815447374, 9664.903350966471, 9707.029297070307, 9739.805203895954, 39699.60300396988, 39753.60246397528, 39844.80077599623, 40045.59954400448, 40125.79622611326, 3185.394774992744, 3405.897823065312, 3417.40195465795, 3513.7189024878203, 3789.5642001169667, 28414.57927103657, 29298.70701292981, 29435.41129177426, 29645.851770741225, 30404.239894002825, 2670.0, 3260.4620237660756, 3321.2029113012945, 3330.533725278463, 3331.217163966466, 429162.0, 501780.0, 511272.0, 513478.0, 513984.9999999963, 58818.41181588215, 58997.82004359889, 59430.702846486354, 59433.10850337248, 59666.0, 59962.40037599568, 61165.694171528856, 61278.77442451126, 61446.69276653678, 61453.38546614477, 16113.436029739138, 16345.427910023092, 16354.264058117413, 16444.0, 16601.667966640598, 12767.744645107232, 12806.487740490462, 12866.228026318451, 12939.611811645666, 13023.47906083765, 15250.847491525165, 15851.445199417965, 15901.045937243802, 15936.884418090855, 15983.680326393407, 3328.201231704422, 6489.253735820346, 7310.488265821447, 7374.26257374269, 7394.889076663854, 882.9117088291248, 956.3974695941512, 979.153032626787, 984.542187882638, 1008.2891561449161, 29052.41895162085, 29971.250718732204, 30120.69879301179, 30516.0, 30638.0, 929.9116583924516, 1053.3995622495258, 1055.0399136785488, 1105.474899422784, 1144.7939370913316, 15122.848771512365, 15417.691646167013, 15647.217639117998, 15659.217039147998, 15951.20243987796, 687727.0, 693871.0, 695656.0, 696327.0, 697623.0, 57721.71139144361, 58360.0, 58895.70552147212, 58895.70552147298, 59032.70483647554, 1374.312843578211, 1408.4295860176644, 1427.3576890399154, 1427.750143724844, 1436.4828661681786, 29393.85303073471, 29863.701362986092, 30708.0, 30809.075727728203, 30934.535981959838, 55843.72078139746, 56221.8755624877, 56612.15081773694, 56637.71681141568, 56726.43273567376, 557312.0, 563082.0, 570356.0, 570363.1481842564, 572792.0, 41504.0, 41960.790196050046, 42475.15049699051, 42482.0, 42894.0, 45124.77437612791, 45931.77034114808, 46135.307970381145, 46493.76753116348, 47360.7631961838, 34045.78862887591, 38349.42475862808, 38456.615433845305, 38830.0, 39117.608823911396, 31080.68919310778, 38837.61162388453, 38856.222875542895, 39945.60054399419, 39955.40066898941, 37719.622803771614, 37777.81111094427, 38357.0, 38385.808070959465, 38801.6119838798, 33446.33107337888, 33691.49462758011, 34981.47527787136, 34984.0, 35008.82495587608, 25705.871470642527, 26111.608325874746, 26135.0, 26185.73814261833, 26720.599191011763], "value": 20096.715057779453, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.9865604703836, 385.32583867956396, 385.50077649443966, 392.83697265634754, 415.250472896422, 19494.51263718406, 20450.386488405373, 20661.173553057877, 20663.690044649324, 21445.142194312248, 20438.89780551095, 20847.583048339024, 20864.47838804031, 20915.581688366223, 21238.36284911455, 5564.666120032791, 5981.192539007244, 6054.212952316193, 6104.96947515264, 6124.510039196876, 5871.941280587203, 5940.524758019348, 6012.188354572142, 6014.8797024059495, 6071.423214794588, 6119.326874043873, 6150.907736383958, 6187.535934804908, 6249.0, 6262.906056409158, 6123.203983482141, 6239.188905442286, 6318.87362252757, 6815.318468153195, 6849.794506164823, 5149.922751158736, 5869.413058694139, 6073.0283154695035, 6081.969590152021, 6085.96538588441, 13356.933215333958, 13555.52555660557, 13754.105983111065, 13805.240711760849, 13901.374438150206, 2295.254042436215, 2432.270318904322, 2449.6570480132796, 2886.2062932693466, 3007.969920300791, 9974.451405172713, 10623.0, 10716.73208169802, 15545.766813497807, 16245.0, 1900.429871038683, 1931.4398824340924, 1959.2750682247517, 2017.9293724719712, 2069.8758074515576, 122080.28558429283, 122788.0, 130219.69780302265, 131008.6899131006, 133144.00283995748, 11676.299422034705, 11915.165938384403, 11937.582184623496, 11969.22200057011, 12226.938865305616, 15045.623859403602, 15097.943143980036, 15109.017913835565, 15116.319765610573, 15136.54590362291, 8814.647414103363, 8895.24390426808, 8971.05803890595, 8978.191962723386, 9015.233705135137, 8764.649414023495, 8765.211130998241, 8832.425892316978, 8888.466691998501, 8941.46351218929, 3859.556151042666, 4666.603338716247, 4674.11191873543, 4703.529647035269, 4734.55021772931, 1989.9303524376867, 2016.9193232270839, 2036.6334059869366, 2057.331367305602, 2063.8348932085396, 735.6101266328855, 911.6399022386253, 934.4299977014016, 996.7970784566045, 1079.400932482464, 20824.58350832975, 21289.148434062772, 21442.142314307253, 21622.243221487173, 21637.242696505546, 923.3628796130648, 967.274544091931, 972.7519482531909, 996.1930836022844, 1007.5063219022626, 10965.780684386267, 11325.433728313552, 11351.60269390584, 11375.374354410587, 12479.251244925334, 614923.0, 616148.0, 622814.0, 630568.0, 631405.0, 94017.99999999863, 102502.46246306312, 127374.0, 128143.0, 139552.0, 962.2830990911815, 999.9150072243941, 1015.6140666546665, 1018.5009345420691, 1018.6231094495084, 17184.828151718822, 17893.836900601418, 18875.433736987914, 19254.71117933204, 19816.90091549533, 52140.739296303276, 53809.0, 54178.729106354214, 54655.72672136614, 56405.71797140988, 75161.62419187868, 75943.62028189824, 76944.0, 77244.2275577237, 77397.61301193683, 8218.096009439076, 8296.170382961656, 8316.41785075039, 8360.581970901552, 8401.32789376836, 12500.437480313225, 12991.350432478528, 13139.802902956271, 13150.27673477968, 13299.46802127904, 9894.0, 11172.49723762449, 11205.383703896365, 11449.141314401286, 11467.598634047768, 10016.799664006825, 10588.417637030037, 11044.116470682166, 11156.776864462827, 11476.540938362372, 9236.445813251226, 11639.301641901513, 11663.59177428786, 11733.823992639946, 11851.170418070997, 8394.24451799341, 11882.584109556125, 12138.514459421878, 12166.878331216574, 12226.388680565758, 5594.664320140804, 5890.823275301748, 11238.719032024264, 11725.0, 11824.054075673754], "value": 9756.961631855327, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.6680930195353, 1534.4195478656982, 1741.3295881085787, 1802.252065392862, 1898.6962086066233, 7812.296893279604, 8073.475224110443, 8195.795105122368, 8650.870236946443, 8675.915510561179, 8240.505569665824, 8462.323014158868, 8469.407141500098, 8504.872426913602, 8518.063013068557, 2348.43637526994, 2353.670486131943, 2375.8455700379504, 2390.294863015406, 2395.856248625088, 2364.172539611131, 2429.7813196812285, 2443.584590619599, 2443.609022556391, 2445.963310550343, 2367.775061369176, 2386.0813586769045, 2403.038784486202, 2406.831521793475, 2412.0231306320966, 2351.294611616508, 2356.375560476475, 2387.283814855545, 2388.796952259043, 2397.4485868250313, 2388.641703744435, 2392.7009123859516, 2392.820538459605, 2421.721502027272, 2428.2715185444295, 8528.872066919, 8531.274841638467, 8561.828763424697, 8571.528565928871, 8640.179182977607, 5230.843074707726, 5355.250264962909, 5386.407495175527, 5392.514673679349, 5404.1083221268445, 3481.0601137692934, 3559.94660080099, 3567.7324200685052, 3591.2458383739445, 3652.7808331500196, 954.9140577348003, 981.1611072532953, 1067.925245232834, 1075.3977772447377, 1118.3010618363523, 10984.615538456115, 11092.445377731161, 11099.38953357565, 11106.666799996014, 11119.444027798658, 4601.5168407317415, 4700.482946875841, 4774.140654682191, 4776.47458779534, 4857.708537487762, 9564.426134431957, 9590.136887680002, 9702.417854928726, 9712.271579631555, 9720.173785228335, 4748.833790817304, 5268.420473747885, 5277.577793776489, 5278.9208161877605, 5374.274472946102, 4232.280512312914, 4327.723321620129, 4466.3747075409465, 4841.806327746851, 4925.876853078702, 3634.254977729559, 3642.125889786485, 3758.774473531597, 3772.3775577030033, 4041.6968727345566, 1293.6442478318538, 1300.9349532523336, 1308.9018323625767, 1319.1689235781396, 1319.2414361742037, 923.612082925173, 941.449252187478, 943.9339246252696, 947.228009172536, 965.8068386322764, 5744.51171650406, 5782.971085144547, 5816.534677225812, 5963.284405871236, 6182.1345011698395, 452.96829221954147, 456.68260558911237, 457.2113104894031, 458.9678722489394, 463.2911645182876, 3944.5463771666628, 3983.3029219886403, 3987.80060996949, 4007.8396864125107, 4087.156719287594, 9524.666636667684, 10019.749506262402, 10094.293399462114, 10232.334898231591, 10285.794284114425, 9942.353747006422, 9996.800063998679, 10157.898421015843, 10168.644097456554, 10303.175745940307, 7824.452288339761, 7855.410844186595, 7985.880211796828, 8035.758927232192, 8053.436259461781, 5523.7238138093735, 5535.0313695104005, 5693.829185124453, 5737.340205876378, 5742.36833948257, 8135.552544610104, 9145.719599256243, 9506.95246523763, 9511.524423778921, 9527.618895244113, 9412.435253884789, 9413.388129771543, 9526.190273826802, 9542.713718588453, 9603.9039609603, 7129.536580122275, 7276.96361518189, 7289.927100728924, 7379.8155046124275, 7389.667464963982, 8119.431639785158, 8127.390445716713, 8184.140665230065, 8191.180881912, 8198.344132469507, 7241.601711905896, 7304.452166087671, 7389.852202956018, 7501.474896757393, 7501.549907005598, 7159.0, 7244.348008679244, 7274.527155734861, 7285.744998925013, 7296.854062918605, 6293.685315734287, 6698.464122870256, 6822.249552549315, 6971.6165610891885, 6997.580145191305, 4905.926411103765, 4984.651074424755, 4989.451160372429, 5089.898202036013, 5140.897182056263, 5028.723420211923, 5106.540411362995, 5139.871503212449, 5146.125158723101, 5187.351581052369], "value": 4445.913740548496, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [252.47989142366723, 305.1334210841212, 315.7237417259898, 317.7251677299137, 319.29435946558107, 5011.423686276079, 5011.949880501194, 5122.898576805986, 5478.876830249799, 5558.63702460012, 4720.90558188836, 5317.893642127165, 5497.312835895513, 5497.4502549745, 5525.4474552544725, 4200.579942005798, 4234.17433600448, 4240.491141063077, 4250.426192464009, 4253.595908388698, 4148.958510414887, 4201.306784380588, 4207.389928460371, 4254.468191476066, 4311.439512863323, 3067.555204495347, 3856.283953640631, 4146.434066702634, 4188.183304255671, 4188.350805625133, 3610.4223324268255, 3858.672012878909, 4155.189738001091, 4215.283401821667, 4230.746155230696, 3356.228067544454, 3483.860645574174, 3672.878053654399, 3688.61269566697, 3722.181120153562, 5011.972545628138, 5215.078400510053, 5259.421463638997, 5345.919811202835, 5348.598855085846, 4810.735409552473, 4838.540338667821, 4860.7326597037145, 4873.537013983666, 4877.926831097537, 5165.19218273605, 5766.365699773063, 5795.971020144914, 5809.564282678816, 5824.796132135355, 3668.578113516953, 3932.154586763831, 3944.1717239379764, 3949.1509325494867, 3962.603739626043, 5791.710414479301, 6026.945284575182, 6095.08573713942, 6175.969120154416, 6176.263360666821, 3982.2433737589763, 3998.5601583825755, 4011.839526418969, 4017.1363156920816, 4027.7784721839994, 3762.774233545996, 4000.179963107556, 4042.604212461488, 4052.2098190852503, 4091.0, 4721.504242054603, 4721.5986641135205, 4744.691595046311, 4759.904801903943, 4765.475797662254, 5821.621594596338, 5829.970850145807, 5853.502452291517, 5853.88292234153, 5889.5877288590245, 1159.96520104397, 1205.4454950722766, 1224.871388504212, 1261.438659796382, 1306.243103026428, 830.4353039932904, 862.8101817600118, 877.2236570634907, 898.2544488075013, 905.9129045145851, 4164.833846522978, 5094.6688465249645, 5221.634485586049, 5223.686578805208, 5283.815066472732, 4603.49361570227, 5055.519725626134, 5392.299001129828, 5433.538149257279, 5672.659640421505, 4380.327999920046, 4609.953900460952, 4800.783964721596, 5188.429272779991, 5195.0, 2698.865056747155, 2719.279390961397, 2770.279727270884, 3029.8182109073527, 3041.0, 5424.0, 5779.88440231193, 5854.385289544622, 5966.523892584615, 6047.2743270806905, 4548.818047278138, 5548.334199896039, 5590.720463976785, 5774.68239246837, 5933.436323549256, 5137.691738495628, 5612.709076912333, 5909.763609455659, 6026.734385779036, 6072.453479186806, 4840.838198832184, 5045.369328833895, 5615.894039735099, 5706.543476521785, 5775.527240553632, 5538.307711536058, 5904.911426328695, 5980.671063091571, 5984.670843103497, 6013.699315034143, 5743.93737158627, 6024.855277497261, 6303.842403939938, 6314.715837787218, 6332.335104814112, 3343.8160901150673, 3782.583915769208, 3987.4218238355857, 4001.8799436016966, 4018.3369743991916, 5758.654480731169, 5987.784519727728, 6014.428629280212, 6023.3374328824675, 6036.607620504653, 5154.659788455104, 5208.661437006583, 5713.143028545752, 5802.738876750472, 5823.242978412779, 5082.957993611227, 5798.884022319446, 5842.883142337215, 5866.472017518444, 5875.236219291465, 4974.801007959786, 5177.715225662625, 5487.5884308677805, 5709.486146246858, 5769.817187476473, 4411.434165638549, 5871.94128058714, 5948.5538584605465, 5956.5532585055425, 5960.155699573837, 5458.77177635029, 5532.336119665666, 5722.656640601577, 5741.578984182072, 5827.572244799881], "value": 4174.481495032654, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.6009194942782, 726.2737262737263, 739.2422766664168, 759.9354054905333, 783.6434422337837, 14758.409663613456, 15826.841731582696, 16569.25438355274, 17021.97868127913, 17197.312107515714, 15896.761548576751, 15962.920185399056, 16277.430289939855, 16288.918555407236, 16521.00873947564, 838.6268110690745, 856.387682806793, 856.8714692796068, 857.789841488833, 858.3991206155684, 853.9871901921476, 876.3952872517942, 879.3844308983705, 881.775147337428, 896.1979028769248, 890.9198172164504, 893.0266010049045, 926.5182105305237, 930.2557953637097, 930.6044930904338, 882.7925437522177, 895.7044175422128, 900.2527901841456, 919.8252332056887, 920.9907900920972, 659.5712786688642, 681.5467713970204, 681.8363592737708, 684.4626967830279, 687.8658661560997, 14709.0, 15018.549443516602, 15023.849761502464, 15247.313870875727, 15442.691146177125, 13784.655383615489, 13967.511137110254, 14025.228612426312, 14128.0, 14229.857701422958, 11543.711407214803, 11683.123765717604, 11877.524899004029, 11906.404679765978, 12021.93989030058, 3418.7265018798685, 3704.3887758519813, 3720.813959302024, 3766.190269092131, 3802.040239993263, 96092.0, 96981.5452768209, 97256.0, 99850.50074749652, 100105.0, 10532.526036328383, 10789.46052697362, 10824.837627435594, 10916.836247456295, 10925.672229833117, 20011.399658010283, 20790.0, 20809.687854682194, 20812.791872081085, 21103.577928441344, 6965.756198533129, 7022.54353467023, 7030.929690703129, 7168.319009694071, 7197.064381630459, 3872.3997780344093, 3947.407888816643, 3961.980190099031, 3964.960350396517, 4002.139539998856, 3410.9488357674654, 3448.0, 3501.702355299777, 3508.1054331145397, 3527.5943266524164, 648.5946283572767, 649.8732747114362, 656.6847913001691, 662.4170729757782, 673.4309508465338, 577.413924866261, 599.5563283170422, 623.4233334165879, 669.9832504187434, 673.7204060315013, 8718.168755488115, 9293.58178881952, 9469.526523673789, 9905.504724763732, 10085.142762865238, 551.8796546301535, 636.8759140117696, 642.2325321241073, 677.7309883576913, 689.5070024932097, 4174.874753757392, 4578.954210457853, 4610.492845786961, 4628.83799067031, 4640.976795116003, 111176.88823111827, 111376.0, 111405.0, 113161.0, 115650.42174789072, 95886.52056739671, 96194.0, 98195.0, 98420.0, 99905.0018999616, 64610.67694661591, 78457.82313265305, 80581.17965871283, 85788.57105714432, 89272.0, 8439.451435656663, 8689.348298877483, 8726.127387261224, 8959.820803583762, 8973.05782892787, 45482.0, 54215.72892135514, 55151.724241378535, 56732.716336419704, 56816.0, 68295.63408731896, 68327.97508037483, 72774.63612681902, 73043.63478182575, 73711.0, 11681.299122052704, 12558.811617825557, 12593.559225427067, 12753.872461275269, 13378.799318010042, 14240.0, 14761.55715328542, 14837.961342705907, 14995.400183992955, 15233.162176079979, 13212.273324966834, 13401.128926619738, 13951.302434878013, 14046.859531404556, 14081.15513069178, 13599.320033998063, 13600.97992650575, 13742.312884355542, 13798.448062077807, 13874.861251387358, 12977.351132443151, 13328.40022198984, 13497.595072147851, 13499.527516536875, 13606.86393136056, 9644.75888102803, 10767.407792571485, 11014.39420831862, 11029.669109926715, 11078.279911805706, 11194.66416007521, 11456.541738330374, 11691.0, 11716.70708232301, 11719.824202636797], "value": 7500.716349649383, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 116.0, 115.0, 113.0, 116.0, 117.0, 116.0, 115.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 107.0, 110.0, 141.0, 126.0, 133.0, 109.0, 112.0, 134.0, 104.0], "value": 121.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 199.0, 195.0, 200.0, 195.0, 192.0, 196.0, 200.0, 204.0, 186.0], "value": 196.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 60.0, 86.0, 63.0, 62.0, 60.0, 63.0, 77.0, 58.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 90.0, 72.0, 71.0, 69.0, 83.0, 68.0, 71.0, 89.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 117.0, 90.0, 93.0, 134.0, 86.0, 92.0, 87.0, 102.0, 135.0], "value": 107.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 87.0, 147.0, 150.0, 94.0, 94.0, 98.0, 104.0, 147.0, 97.0], "value": 116.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 86.0, 87.0, 95.0, 87.0, 91.0, 89.0, 89.0, 91.0], "value": 99.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 57.0, 58.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 90.0, 102.0, 70.0, 97.0, 105.0, 96.0, 89.0, 69.0, 68.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 84.0, 104.0, 104.0, 83.0, 87.0, 89.0, 83.0, 83.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 137.0, 138.0, 144.0, 139.0, 142.0, 173.0, 183.0, 152.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 164.0, 166.0, 166.0, 167.0, 171.0, 192.0, 226.0, 177.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 68.0, 72.0], "value": 66.9, "unit": "score"}]}]} 07:52:45 INFO - Return code: 0 07:52:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:52:45 ERROR - # TBPL SUCCESS # 07:52:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:52:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:52:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:52:45 INFO - 2017-02-03 07:52:45.775 screenresolution[1847:11045] starting screenresolution argv=screenresolution get 07:52:45 INFO - 2017-02-03 07:52:45.779 screenresolution[1847:11045] Display 0: 1600x1200x32@60 07:52:45 INFO - 2017-02-03 07:52:45.785 screenresolution[1848:11048] starting screenresolution argv=screenresolution list 07:52:45 INFO - Available Modes on Display 0 07:52:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:52:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:52:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:52:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:52:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:52:46 INFO - Intel Iris: 07:52:46 INFO - Chipset Model: Intel Iris 07:52:46 INFO - Type: GPU 07:52:46 INFO - Bus: Built-In 07:52:46 INFO - VRAM (Dynamic, Max): 1536 MB 07:52:46 INFO - Vendor: Intel (0x8086) 07:52:46 INFO - Device ID: 0x0a2e 07:52:46 INFO - Revision ID: 0x0009 07:52:46 INFO - Displays: 07:52:46 INFO - Display: 07:52:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:52:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:52:46 INFO - Display Serial Number: 1600x1200 60 07:52:46 INFO - Main Display: Yes 07:52:46 INFO - Mirror: Off 07:52:46 INFO - Online: Yes 07:52:46 INFO - Rotation: Supported 07:52:46 INFO - Return code: 0 07:52:46 INFO - Running post-action listener: _resource_record_post_action 07:52:46 INFO - [mozharness: 2017-02-03 15:52:46.028376Z] Finished run-tests step (success) 07:52:46 INFO - Running post-run listener: _resource_record_post_run 07:52:46 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 34029568; Write bytes: 508302848; Read time: 206; Write time: 1701 07:52:46 INFO - TinderboxPrint: CPU usage
54.3% 07:52:46 INFO - TinderboxPrint: I/O read bytes / time
34,029,568 / 206 07:52:46 INFO - TinderboxPrint: I/O write bytes / time
508,302,848 / 1,701 07:52:46 INFO - TinderboxPrint: CPU idle
2,190.8 (45.7%) 07:52:46 INFO - TinderboxPrint: CPU system
968.4 (20.2%) 07:52:46 INFO - TinderboxPrint: CPU user
1,630.3 (34.0%) 07:52:46 INFO - TinderboxPrint: Swap in / out
222,044,160 / 0 07:52:46 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 179032576; Write bytes: 176972288; Read time: 16598; Write time: 402 07:52:46 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 33095680; Write bytes: 313598976; Read time: 194; Write time: 1244 07:52:46 INFO - Running post-run listener: _upload_blobber_files 07:52:46 INFO - Blob upload gear active. 07:52:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:52:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:52:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:52:46 INFO - (blobuploader) - INFO - Open directory for files ... 07:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:48 INFO - (blobuploader) - INFO - Done attempting. 07:52:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:52:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:52:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:49 INFO - (blobuploader) - INFO - Done attempting. 07:52:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:52:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:52:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:51 INFO - (blobuploader) - INFO - Done attempting. 07:52:51 INFO - (blobuploader) - INFO - Iteration through files over. 07:52:51 INFO - Return code: 0 07:52:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:52:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:52:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fff88170b1e6dc23adb087dd51ec9c469a6ded697a703eaa22bcec7d7206e7aaec1abb995b26910dfb4f5220769e6e6622a99603c217ae161408f3d44bf3e802", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf167626644762f23ca7e4455e381b9f8fed77377bc7925dff8c6b7776a83fbe3ca58c07cfa074e8f0a4c8f1931c2fab7bb78a156330831a0def37356808ba0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c423533c1a70e836e448066a45b40544fb419f0f6f0514e0b92e004466abd2f083254b59fb12d969f38e31724c537c0f0130862af6d7f61cc0c307ffe98286bf"} 07:52:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:52:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:52:51 INFO - Contents: 07:52:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fff88170b1e6dc23adb087dd51ec9c469a6ded697a703eaa22bcec7d7206e7aaec1abb995b26910dfb4f5220769e6e6622a99603c217ae161408f3d44bf3e802", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf167626644762f23ca7e4455e381b9f8fed77377bc7925dff8c6b7776a83fbe3ca58c07cfa074e8f0a4c8f1931c2fab7bb78a156330831a0def37356808ba0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c423533c1a70e836e448066a45b40544fb419f0f6f0514e0b92e004466abd2f083254b59fb12d969f38e31724c537c0f0130862af6d7f61cc0c307ffe98286bf"} 07:52:51 INFO - Running post-run listener: copy_logs_to_upload_dir 07:52:51 INFO - Copying logs to upload dir... 07:52:51 INFO - mkdir: /builds/slave/test/build/upload/logs 07:52:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.452053 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-03 07:52:51.585811) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 07:52:51.589704) ========= 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.3akdj9dLAy/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.0w5wjwQETQ/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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/Mozilla-Beta/sha512/fff88170b1e6dc23adb087dd51ec9c469a6ded697a703eaa22bcec7d7206e7aaec1abb995b26910dfb4f5220769e6e6622a99603c217ae161408f3d44bf3e802", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf167626644762f23ca7e4455e381b9f8fed77377bc7925dff8c6b7776a83fbe3ca58c07cfa074e8f0a4c8f1931c2fab7bb78a156330831a0def37356808ba0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c423533c1a70e836e448066a45b40544fb419f0f6f0514e0b92e004466abd2f083254b59fb12d969f38e31724c537c0f0130862af6d7f61cc0c307ffe98286bf"} build_url:https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011037 build_url: 'https://queue.taskcluster.net/v1/task/Vsabl9EhTdOt5kz97fsfUQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fff88170b1e6dc23adb087dd51ec9c469a6ded697a703eaa22bcec7d7206e7aaec1abb995b26910dfb4f5220769e6e6622a99603c217ae161408f3d44bf3e802", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf167626644762f23ca7e4455e381b9f8fed77377bc7925dff8c6b7776a83fbe3ca58c07cfa074e8f0a4c8f1931c2fab7bb78a156330831a0def37356808ba0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c423533c1a70e836e448066a45b40544fb419f0f6f0514e0b92e004466abd2f083254b59fb12d969f38e31724c537c0f0130862af6d7f61cc0c307ffe98286bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 07:52:51.624383) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 07:52:51.624706) ========= 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.3akdj9dLAy/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.0w5wjwQETQ/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.005026 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 07:52:51.673231) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 07:52:51.673554) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 07:52:51.673864) ========= ========= Total master_lag: 0.36 =========