builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0080 starttime: 1477515052.55 results: success (0) buildid: 20161026075526 builduid: 1b6e62fa11104b93a83fb80681645e95 revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.551348) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.551679) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.551941) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.606200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.606661) ========= 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.NkCX5bdFyJ/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.8UlWh8poki/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-26 13:50:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.64M=0.001s 2016-10-26 13:50:53 (9.64 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.573167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.200966) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.201292) ========= 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.NkCX5bdFyJ/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.8UlWh8poki/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.025264 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.249914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.250255) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NkCX5bdFyJ/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.8UlWh8poki/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-26 13:50:53,325 truncating revision to first 12 chars 2016-10-26 13:50:53,325 Setting DEBUG logging. 2016-10-26 13:50:53,325 attempt 1/10 2016-10-26 13:50:53,325 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d26ac63f1b81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 13:50:54,018 unpacking tar archive at: mozilla-central-d26ac63f1b81/testing/mozharness/ program finished with exit code 0 elapsedTime=0.956648 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.228492) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.228938) ========= script_repo_revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.229388) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.229674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.248073) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-26 13:50:54.248480) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NkCX5bdFyJ/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.8UlWh8poki/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:50:54 INFO - MultiFileLogger online at 20161026 13:50:54 in /builds/slave/test 13:50:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:50:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:50:54 INFO - {'append_to_log': False, 13:50:54 INFO - 'base_work_dir': '/builds/slave/test', 13:50:54 INFO - 'blob_upload_branch': 'Firefox', 13:50:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:50:54 INFO - 'branch': 'Firefox', 13:50:54 INFO - 'buildbot_json_path': 'buildprops.json', 13:50:54 INFO - 'config_files': ('talos/mac_config.py',), 13:50:54 INFO - 'default_actions': ('clobber', 13:50:54 INFO - 'read-buildbot-config', 13:50:54 INFO - 'download-and-extract', 13:50:54 INFO - 'populate-webroot', 13:50:54 INFO - 'create-virtualenv', 13:50:54 INFO - 'install', 13:50:54 INFO - 'run-tests'), 13:50:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:50:54 INFO - 'download_minidump_stackwalk': True, 13:50:54 INFO - 'download_symbols': 'ondemand', 13:50:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:50:54 INFO - 'tooltool.py': '/tools/tooltool.py', 13:50:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:50:54 INFO - '/tools/misc-python/virtualenv.py')}, 13:50:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:50:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:50:54 INFO - 'installer_path': 'installer.exe', 13:50:54 INFO - 'log_level': 'info', 13:50:54 INFO - 'log_name': 'talos', 13:50:54 INFO - 'log_to_console': True, 13:50:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:50:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:50:54 INFO - 'opt_config_files': (), 13:50:54 INFO - 'pip_index': False, 13:50:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:54 INFO - 'cmd': ('bash', 13:50:54 INFO - '-c', 13:50:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:54 INFO - 'enabled': True, 13:50:54 INFO - 'halt_on_failure': False, 13:50:54 INFO - 'name': 'check_screen_resolution'},), 13:50:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:54 INFO - 'cmd': ('bash', 13:50:54 INFO - '-c', 13:50:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:54 INFO - 'enabled': True, 13:50:54 INFO - 'halt_on_failure': False, 13:50:54 INFO - 'name': 'check_screen_resolution'},), 13:50:54 INFO - 'run_cmd_checks_enabled': True, 13:50:54 INFO - 'sps_profile': False, 13:50:54 INFO - 'sps_profile_interval': 0, 13:50:54 INFO - 'suite': 'dromaeojs-e10s', 13:50:54 INFO - 'system_bits': '32', 13:50:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:50:54 INFO - 'title': 't-yosemite-r7-0080', 13:50:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:50:54 INFO - 'use_talos_json': True, 13:50:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:50:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:50:54 INFO - 'work_dir': 'build'} 13:50:54 INFO - [mozharness: 2016-10-26 20:50:54.452885Z] Running clobber step. 13:50:54 INFO - Running pre-action listener: _resource_record_pre_action 13:50:54 INFO - Running main action method: clobber 13:50:54 INFO - rmtree: /builds/slave/test/build 13:50:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:50:56 INFO - Running post-action listener: _resource_record_post_action 13:50:56 INFO - [mozharness: 2016-10-26 20:50:56.597142Z] Finished clobber step (success) 13:50:56 INFO - [mozharness: 2016-10-26 20:50:56.597298Z] Running read-buildbot-config step. 13:50:56 INFO - Running pre-action listener: _resource_record_pre_action 13:50:56 INFO - Running main action method: read_buildbot_config 13:50:56 INFO - Using buildbot properties: 13:50:56 INFO - { 13:50:56 INFO - "project": "", 13:50:56 INFO - "product": "firefox", 13:50:56 INFO - "script_repo_revision": "production", 13:50:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:50:56 INFO - "repository": "", 13:50:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:50:56 INFO - "buildid": "20161026075526", 13:50:56 INFO - "pgo_build": "False", 13:50:56 INFO - "basedir": "/builds/slave/test", 13:50:56 INFO - "buildnumber": 51, 13:50:56 INFO - "slavename": "t-yosemite-r7-0080", 13:50:56 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:50:56 INFO - "platform": "yosemite_r7", 13:50:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:50:56 INFO - "branch": "mozilla-central", 13:50:56 INFO - "repo_path": "mozilla-central", 13:50:56 INFO - "revision": "d26ac63f1b81c3fce35448a7c502e95e0b5c56c0", 13:50:56 INFO - "stage_platform": "macosx64", 13:50:56 INFO - "builduid": "1b6e62fa11104b93a83fb80681645e95", 13:50:56 INFO - "slavebuilddir": "test" 13:50:56 INFO - } 13:50:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:50:56 INFO - Running post-action listener: _resource_record_post_action 13:50:56 INFO - [mozharness: 2016-10-26 20:50:56.600811Z] Finished read-buildbot-config step (success) 13:50:56 INFO - [mozharness: 2016-10-26 20:50:56.600924Z] Running download-and-extract step. 13:50:56 INFO - Running pre-action listener: _resource_record_pre_action 13:50:56 INFO - Running main action method: download_and_extract 13:50:56 INFO - mkdir: /builds/slave/test/build/tests 13:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:56 INFO - trying https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:56 INFO - Downloading https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 13:50:58 INFO - Downloaded 1199 bytes. 13:50:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:58 INFO - Using the following test package requirements: 13:50:58 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:50:58 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:50:58 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:50:58 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'jsshell-mac.zip'], 13:50:58 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:50:58 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:50:58 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:50:58 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:50:58 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:50:58 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:50:58 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:50:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:50:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:50:58 INFO - Fetch https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:50:58 INFO - Http code: 200 13:50:58 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 13:50:58 INFO - x-amz-cf-id: 5jOI3Gjm5eeh8IVzQ4tb5qjG7TOuy1jgvmCI6e7PglzoYJlqg4UT0g== 13:50:58 INFO - x-amz-version-id: oYs0S0BWLue4d5yNfzrDOVXSMP0of8m4 13:50:59 INFO - Expected file size: 16442708 13:50:59 INFO - Obtained file size: 16442708 13:51:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:51:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:51:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:51:05 INFO - Fetch https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:51:06 INFO - Http code: 200 13:51:06 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 13:51:06 INFO - x-amz-cf-id: gcUSUD9y2DLnRVtUdKAyhOWdq67JGTs_7pdQdNaybkLSYC6nwjnlug== 13:51:06 INFO - x-amz-version-id: oYs0S0BWLue4d5yNfzrDOVXSMP0of8m4 13:51:06 INFO - Expected file size: 16442708 13:51:06 INFO - Obtained file size: 16442708 13:51:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 13:51:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:51:13 INFO - Fetch https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 13:51:13 INFO - Http code: 200 13:51:13 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 13:51:13 INFO - x-amz-cf-id: cQJ0cUxTZKbt1-e2uobvrVGZ6yic3uJ-6Sq7jq3U8hPLz8LTH9DzeA== 13:51:13 INFO - x-amz-version-id: 0bXUQ92dp_r4joro14ZW7j22G0F3vbr6 13:51:13 INFO - Expected file size: 14409028 13:51:13 INFO - Obtained file size: 14409028 13:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:14 INFO - trying https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:14 INFO - Downloading https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 13:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 13:51:17 INFO - Downloaded 111730824 bytes. 13:51:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:17 INFO - mkdir: /builds/slave/test/properties 13:51:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:51:17 INFO - Writing to file /builds/slave/test/properties/build_url 13:51:17 INFO - Contents: 13:51:17 INFO - build_url:https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:18 INFO - Running post-action listener: _resource_record_post_action 13:51:18 INFO - Running post-action listener: set_extra_try_arguments 13:51:18 INFO - [mozharness: 2016-10-26 20:51:18.217935Z] Finished download-and-extract step (success) 13:51:18 INFO - [mozharness: 2016-10-26 20:51:18.218088Z] Running populate-webroot step. 13:51:18 INFO - Running pre-action listener: _resource_record_pre_action 13:51:18 INFO - Running main action method: populate_webroot 13:51:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:51:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:51:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:51:18 INFO - '--tppagecycles', 13:51:18 INFO - '7'], 13:51:18 INFO - 'tests': ['tsvgm']}}, 13:51:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:51:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:51:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:51:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:51:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['damp', 'tps']}, 13:51:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'tests': ['damp', 'tps']}, 13:51:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['dromaeo_dom']}, 13:51:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:51:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['basic_compositor_video']}, 13:51:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:51:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other-e10s': {'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['tsvgx', 13:51:18 INFO - 'tsvgr_opacity', 13:51:18 INFO - 'tart', 13:51:18 INFO - 'tscrollx', 13:51:18 INFO - 'cart']}, 13:51:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:51:18 INFO - 'tsvgr_opacity', 13:51:18 INFO - 'tart', 13:51:18 INFO - 'tscrollx', 13:51:18 INFO - 'cart']}, 13:51:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['tp5o']}, 13:51:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'tests': ['tp5o']}, 13:51:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--disable-e10s', 13:51:18 INFO - '--xperf_path', 13:51:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:18 INFO - 'tests': ['tp5n']}, 13:51:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--xperf_path', 13:51:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:18 INFO - 'tests': ['tp5n']}}, 13:51:18 INFO - 'talos.zip': {'path': '', 13:51:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:51:18 INFO - Running post-action listener: _resource_record_post_action 13:51:18 INFO - [mozharness: 2016-10-26 20:51:18.236527Z] Finished populate-webroot step (success) 13:51:18 INFO - [mozharness: 2016-10-26 20:51:18.236666Z] Running create-virtualenv step. 13:51:18 INFO - Running pre-action listener: _resource_record_pre_action 13:51:18 INFO - Running main action method: create_virtualenv 13:51:18 INFO - Creating virtualenv /builds/slave/test/build/venv 13:51:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:51:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:51:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:51:18 INFO - Using real prefix '/tools/python27' 13:51:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:51:19 INFO - Installing distribute.............................................................................................................................................................................................done. 13:51:21 INFO - Installing pip.................done. 13:51:21 INFO - Return code: 0 13:51:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:51:22 INFO - Reading from file tmpfile_stdout 13:51:22 INFO - Output received: 13:51:22 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:51:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:22 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 0x10ef87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eefd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc870461e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed9bd30>, '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 0x10ebc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed93b20>, '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.NkCX5bdFyJ/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.8UlWh8poki/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:51:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkCX5bdFyJ/Render', 13:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:22 INFO - 'HOME': '/Users/cltbld', 13:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:22 INFO - 'LOGNAME': 'cltbld', 13:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:22 INFO - 'MOZ_NO_REMOTE': '1', 13:51:22 INFO - 'NO_EM_RESTART': '1', 13:51:22 INFO - 'PAGER': '/bin/cat', 13:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:22 INFO - 'PWD': '/builds/slave/test', 13:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:22 INFO - 'SHELL': '/bin/bash', 13:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8UlWh8poki/Listeners', 13:51:22 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 13:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:22 INFO - 'USER': 'cltbld', 13:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:22 INFO - 'XPC_FLAGS': '0x0', 13:51:22 INFO - 'XPC_SERVICE_NAME': '0', 13:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:51:22 INFO - Cleaning up... 13:51:22 INFO - Return code: 0 13:51:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:22 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 0x10ef87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eefd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc870461e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed9bd30>, '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 0x10ebc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed93b20>, '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.NkCX5bdFyJ/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.8UlWh8poki/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:51:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkCX5bdFyJ/Render', 13:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:22 INFO - 'HOME': '/Users/cltbld', 13:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:22 INFO - 'LOGNAME': 'cltbld', 13:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:22 INFO - 'MOZ_NO_REMOTE': '1', 13:51:22 INFO - 'NO_EM_RESTART': '1', 13:51:22 INFO - 'PAGER': '/bin/cat', 13:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:22 INFO - 'PWD': '/builds/slave/test', 13:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:22 INFO - 'SHELL': '/bin/bash', 13:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8UlWh8poki/Listeners', 13:51:22 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 13:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:22 INFO - 'USER': 'cltbld', 13:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:22 INFO - 'XPC_FLAGS': '0x0', 13:51:22 INFO - 'XPC_SERVICE_NAME': '0', 13:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:22 INFO - Downloading/unpacking psutil>=3.1.1 13:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:51:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:26 INFO - Installing collected packages: psutil 13:51:26 INFO - Running setup.py install for psutil 13:51:26 INFO - building 'psutil._psutil_osx' extension 13:51:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:51:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:51:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:51:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:51:27 INFO - building 'psutil._psutil_posix' extension 13:51:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:51:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:51:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:51:27 INFO - ^ 13:51:27 INFO - 1 warning generated. 13:51:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:51:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:27 INFO - Successfully installed psutil 13:51:27 INFO - Cleaning up... 13:51:27 INFO - Return code: 0 13:51:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eefd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc870461e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed9bd30>, '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 0x10ebc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed93b20>, '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.NkCX5bdFyJ/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.8UlWh8poki/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:51:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkCX5bdFyJ/Render', 13:51:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:27 INFO - 'HOME': '/Users/cltbld', 13:51:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:27 INFO - 'LOGNAME': 'cltbld', 13:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:27 INFO - 'MOZ_NO_REMOTE': '1', 13:51:27 INFO - 'NO_EM_RESTART': '1', 13:51:27 INFO - 'PAGER': '/bin/cat', 13:51:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:27 INFO - 'PWD': '/builds/slave/test', 13:51:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:27 INFO - 'SHELL': '/bin/bash', 13:51:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8UlWh8poki/Listeners', 13:51:27 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 13:51:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:27 INFO - 'USER': 'cltbld', 13:51:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:27 INFO - 'XPC_FLAGS': '0x0', 13:51:27 INFO - 'XPC_SERVICE_NAME': '0', 13:51:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:51:30 INFO - Installing collected packages: mozsystemmonitor 13:51:30 INFO - Running setup.py install for mozsystemmonitor 13:51:30 INFO - Successfully installed mozsystemmonitor 13:51:30 INFO - Cleaning up... 13:51:30 INFO - Return code: 0 13:51:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eefd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc870461e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed9bd30>, '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 0x10ebc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed93b20>, '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.NkCX5bdFyJ/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.8UlWh8poki/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkCX5bdFyJ/Render', 13:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:30 INFO - 'HOME': '/Users/cltbld', 13:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:30 INFO - 'LOGNAME': 'cltbld', 13:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:30 INFO - 'MOZ_NO_REMOTE': '1', 13:51:30 INFO - 'NO_EM_RESTART': '1', 13:51:30 INFO - 'PAGER': '/bin/cat', 13:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:30 INFO - 'PWD': '/builds/slave/test', 13:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:30 INFO - 'SHELL': '/bin/bash', 13:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8UlWh8poki/Listeners', 13:51:30 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 13:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:30 INFO - 'USER': 'cltbld', 13:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:30 INFO - 'XPC_FLAGS': '0x0', 13:51:30 INFO - 'XPC_SERVICE_NAME': '0', 13:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:31 INFO - Downloading/unpacking jsonschema==2.5.1 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:51:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:34 INFO - Downloading functools32-3.2.3-2.tar.gz 13:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:51:34 INFO - warning: no files found matching '*.txt' 13:51:34 INFO - no previously-included directories found matching 'build' 13:51:34 INFO - no previously-included directories found matching 'dist' 13:51:34 INFO - no previously-included directories found matching '.git*' 13:51:34 INFO - Installing collected packages: jsonschema, functools32 13:51:34 INFO - Running setup.py install for functools32 13:51:34 INFO - warning: no files found matching '*.txt' 13:51:34 INFO - no previously-included directories found matching 'build' 13:51:34 INFO - no previously-included directories found matching 'dist' 13:51:34 INFO - no previously-included directories found matching '.git*' 13:51:34 INFO - Successfully installed jsonschema functools32 13:51:34 INFO - Cleaning up... 13:51:34 INFO - Return code: 0 13:51:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:34 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 0x10ef87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eefd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc870461e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed9bd30>, '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 0x10ebc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed93b20>, '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.NkCX5bdFyJ/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.8UlWh8poki/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkCX5bdFyJ/Render', 13:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:34 INFO - 'HOME': '/Users/cltbld', 13:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:34 INFO - 'LOGNAME': 'cltbld', 13:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:34 INFO - 'MOZ_NO_REMOTE': '1', 13:51:34 INFO - 'NO_EM_RESTART': '1', 13:51:34 INFO - 'PAGER': '/bin/cat', 13:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:34 INFO - 'PWD': '/builds/slave/test', 13:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:34 INFO - 'SHELL': '/bin/bash', 13:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8UlWh8poki/Listeners', 13:51:34 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 13:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:34 INFO - 'USER': 'cltbld', 13:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:34 INFO - 'XPC_FLAGS': '0x0', 13:51:34 INFO - 'XPC_SERVICE_NAME': '0', 13:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:51:34 INFO - Cleaning up... 13:51:34 INFO - Return code: 0 13:51:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:34 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 0x10ef87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eefd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc870461e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed9bd30>, '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 0x10ebc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed93b20>, '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.NkCX5bdFyJ/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.8UlWh8poki/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkCX5bdFyJ/Render', 13:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:34 INFO - 'HOME': '/Users/cltbld', 13:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:34 INFO - 'LOGNAME': 'cltbld', 13:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:34 INFO - 'MOZ_NO_REMOTE': '1', 13:51:34 INFO - 'NO_EM_RESTART': '1', 13:51:34 INFO - 'PAGER': '/bin/cat', 13:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:34 INFO - 'PWD': '/builds/slave/test', 13:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:34 INFO - 'SHELL': '/bin/bash', 13:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8UlWh8poki/Listeners', 13:51:34 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 13:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:34 INFO - 'USER': 'cltbld', 13:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:34 INFO - 'XPC_FLAGS': '0x0', 13:51:34 INFO - 'XPC_SERVICE_NAME': '0', 13:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:35 INFO - Downloading/unpacking blobuploader==1.2.4 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:37 INFO - Downloading blobuploader-1.2.4.tar.gz 13:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:51:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:51:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:38 INFO - Downloading docopt-0.6.1.tar.gz 13:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:51:38 INFO - Installing collected packages: blobuploader, requests, docopt 13:51:38 INFO - Running setup.py install for blobuploader 13:51:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:51:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:51:39 INFO - Running setup.py install for requests 13:51:39 INFO - Running setup.py install for docopt 13:51:39 INFO - Successfully installed blobuploader requests docopt 13:51:39 INFO - Cleaning up... 13:51:39 INFO - Return code: 0 13:51:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:39 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 0x10ef87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eefd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc870461e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed9bd30>, '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 0x10ebc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed93b20>, '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.NkCX5bdFyJ/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.8UlWh8poki/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkCX5bdFyJ/Render', 13:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:39 INFO - 'HOME': '/Users/cltbld', 13:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:39 INFO - 'LOGNAME': 'cltbld', 13:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:39 INFO - 'MOZ_NO_REMOTE': '1', 13:51:39 INFO - 'NO_EM_RESTART': '1', 13:51:39 INFO - 'PAGER': '/bin/cat', 13:51:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:39 INFO - 'PWD': '/builds/slave/test', 13:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:39 INFO - 'SHELL': '/bin/bash', 13:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8UlWh8poki/Listeners', 13:51:39 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 13:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:39 INFO - 'USER': 'cltbld', 13:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:39 INFO - 'XPC_FLAGS': '0x0', 13:51:39 INFO - 'XPC_SERVICE_NAME': '0', 13:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-ljb_F1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-0fjrzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-P7AzfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-IHhtCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-JryS5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-aCykRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-RA4XX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-rHXmwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-biBkqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-MdWAMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-iuLQ27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Irc5yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-8bbUjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-UIJtrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-5UaUmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-otIeej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-rFzr0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:51:41 INFO - Running setup.py install for manifestparser 13:51:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Running setup.py install for mozcrash 13:51:42 INFO - Running setup.py install for mozdebug 13:51:42 INFO - Running setup.py install for mozdevice 13:51:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Running setup.py install for mozfile 13:51:42 INFO - Running setup.py install for mozhttpd 13:51:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Running setup.py install for mozinfo 13:51:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Running setup.py install for mozInstall 13:51:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Running setup.py install for mozleak 13:51:43 INFO - Running setup.py install for mozlog 13:51:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Running setup.py install for moznetwork 13:51:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Running setup.py install for mozprocess 13:51:43 INFO - Running setup.py install for mozprofile 13:51:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Running setup.py install for mozrunner 13:51:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Running setup.py install for mozscreenshot 13:51:44 INFO - Running setup.py install for moztest 13:51:44 INFO - Running setup.py install for mozversion 13:51:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:51:44 INFO - Cleaning up... 13:51:44 INFO - Return code: 0 13:51:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:44 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 0x10ef87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eefd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc870461e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed9bd30>, '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 0x10ebc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed93b20>, '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.NkCX5bdFyJ/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.8UlWh8poki/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:51:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkCX5bdFyJ/Render', 13:51:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:44 INFO - 'HOME': '/Users/cltbld', 13:51:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:44 INFO - 'LOGNAME': 'cltbld', 13:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:44 INFO - 'MOZ_NO_REMOTE': '1', 13:51:44 INFO - 'NO_EM_RESTART': '1', 13:51:44 INFO - 'PAGER': '/bin/cat', 13:51:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:44 INFO - 'PWD': '/builds/slave/test', 13:51:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:44 INFO - 'SHELL': '/bin/bash', 13:51:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8UlWh8poki/Listeners', 13:51:44 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 13:51:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:44 INFO - 'USER': 'cltbld', 13:51:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:44 INFO - 'XPC_FLAGS': '0x0', 13:51:44 INFO - 'XPC_SERVICE_NAME': '0', 13:51:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-CyWdr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-yIfpO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-FYI3gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-nYiZrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-JJC_sN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-qbGS0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-6sXe4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Soyo2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-JfjW4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-U56fc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Vsiq8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-rJ1IIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-obyonQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:46 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-TGfieo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:46 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-357MFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:46 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-gICqeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:46 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-GxzJRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:51:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:48 INFO - Downloading blessings-1.6.tar.gz 13:51:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:49 INFO - Installing collected packages: blessings 13:51:49 INFO - Running setup.py install for blessings 13:51:49 INFO - Successfully installed blessings 13:51:49 INFO - Cleaning up... 13:51:49 INFO - Return code: 0 13:51:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:49 INFO - Reading from file tmpfile_stdout 13:51:49 INFO - Current package versions: 13:51:49 INFO - blessings == 1.6 13:51:49 INFO - blobuploader == 1.2.4 13:51:49 INFO - docopt == 0.6.1 13:51:49 INFO - functools32 == 3.2.3-2 13:51:49 INFO - jsonschema == 2.5.1 13:51:49 INFO - manifestparser == 1.1 13:51:49 INFO - mozInstall == 1.12 13:51:49 INFO - mozcrash == 0.17 13:51:49 INFO - mozdebug == 0.1 13:51:49 INFO - mozdevice == 0.48 13:51:49 INFO - mozfile == 1.2 13:51:49 INFO - mozhttpd == 0.7 13:51:49 INFO - mozinfo == 0.9 13:51:49 INFO - mozleak == 0.1 13:51:49 INFO - mozlog == 3.4 13:51:49 INFO - moznetwork == 0.27 13:51:49 INFO - mozprocess == 0.23 13:51:49 INFO - mozprofile == 0.28 13:51:49 INFO - mozrunner == 6.12 13:51:49 INFO - mozscreenshot == 0.1 13:51:49 INFO - mozsystemmonitor == 0.3 13:51:49 INFO - moztest == 0.7 13:51:49 INFO - mozversion == 1.4 13:51:49 INFO - psutil == 3.1.1 13:51:49 INFO - requests == 1.2.3 13:51:49 INFO - wsgiref == 0.1.2 13:51:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eefd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc870461e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed9bd30>, '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 0x10ebc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed93b20>, '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.NkCX5bdFyJ/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.8UlWh8poki/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:51:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkCX5bdFyJ/Render', 13:51:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:49 INFO - 'HOME': '/Users/cltbld', 13:51:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:49 INFO - 'LOGNAME': 'cltbld', 13:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:49 INFO - 'MOZ_NO_REMOTE': '1', 13:51:49 INFO - 'NO_EM_RESTART': '1', 13:51:49 INFO - 'PAGER': '/bin/cat', 13:51:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:49 INFO - 'PWD': '/builds/slave/test', 13:51:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:49 INFO - 'SHELL': '/bin/bash', 13:51:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8UlWh8poki/Listeners', 13:51:49 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 13:51:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:49 INFO - 'USER': 'cltbld', 13:51:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:49 INFO - 'XPC_FLAGS': '0x0', 13:51:49 INFO - 'XPC_SERVICE_NAME': '0', 13:51:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:51:49 INFO - Cleaning up... 13:51:49 INFO - Return code: 0 13:51:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eefd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc870461e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed9bd30>, '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 0x10ebc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed93b20>, '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.NkCX5bdFyJ/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.8UlWh8poki/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:51:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkCX5bdFyJ/Render', 13:51:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:49 INFO - 'HOME': '/Users/cltbld', 13:51:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:49 INFO - 'LOGNAME': 'cltbld', 13:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:49 INFO - 'MOZ_NO_REMOTE': '1', 13:51:49 INFO - 'NO_EM_RESTART': '1', 13:51:49 INFO - 'PAGER': '/bin/cat', 13:51:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:49 INFO - 'PWD': '/builds/slave/test', 13:51:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:49 INFO - 'SHELL': '/bin/bash', 13:51:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8UlWh8poki/Listeners', 13:51:49 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 13:51:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:49 INFO - 'USER': 'cltbld', 13:51:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:49 INFO - 'XPC_FLAGS': '0x0', 13:51:49 INFO - 'XPC_SERVICE_NAME': '0', 13:51:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:51:50 INFO - Cleaning up... 13:51:50 INFO - Return code: 0 13:51:50 INFO - Running post-action listener: _resource_record_post_action 13:51:50 INFO - Running post-action listener: _start_resource_monitoring 13:51:50 INFO - Starting resource monitoring. 13:51:50 INFO - [mozharness: 2016-10-26 20:51:50.104462Z] Finished create-virtualenv step (success) 13:51:50 INFO - [mozharness: 2016-10-26 20:51:50.105478Z] Running install step. 13:51:50 INFO - Running pre-action listener: _resource_record_pre_action 13:51:50 INFO - Running main action method: install 13:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:50 INFO - Reading from file tmpfile_stdout 13:51:50 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:50 INFO - Reading from file tmpfile_stdout 13:51:50 INFO - Output received: 13:51:50 INFO - Usage: mozinstall [options] installer 13:51:50 INFO - Options: 13:51:50 INFO - -h, --help show this help message and exit 13:51:50 INFO - -d DEST, --destination=DEST 13:51:50 INFO - Directory to install application into. [default: 13:51:50 INFO - "/builds/slave/test"] 13:51:50 INFO - --app=APP Application being installed. [default: firefox] 13:51:50 INFO - mkdir: /builds/slave/test/build/application 13:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:52:24 INFO - Reading from file tmpfile_stdout 13:52:24 INFO - Output received: 13:52:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:52:24 INFO - Running post-action listener: _resource_record_post_action 13:52:24 INFO - [mozharness: 2016-10-26 20:52:24.874503Z] Finished install step (success) 13:52:24 INFO - [mozharness: 2016-10-26 20:52:24.874683Z] Running run-tests step. 13:52:24 INFO - Running pre-action listener: _resource_record_pre_action 13:52:24 INFO - Running main action method: run_tests 13:52:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:52:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:52:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:52:24 INFO - 2016-10-26 13:52:24.889 screenresolution[1641:8309] starting screenresolution argv=screenresolution get 13:52:24 INFO - 2016-10-26 13:52:24.891 screenresolution[1641:8309] Display 0: 1600x1200x32@60 13:52:24 INFO - 2016-10-26 13:52:24.897 screenresolution[1642:8311] starting screenresolution argv=screenresolution list 13:52:24 INFO - Available Modes on Display 0 13:52:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:52:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:52:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:52:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:52:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:52:25 INFO - Intel Iris: 13:52:25 INFO - Chipset Model: Intel Iris 13:52:25 INFO - Type: GPU 13:52:25 INFO - Bus: Built-In 13:52:25 INFO - VRAM (Dynamic, Max): 1536 MB 13:52:25 INFO - Vendor: Intel (0x8086) 13:52:25 INFO - Device ID: 0x0a2e 13:52:25 INFO - Revision ID: 0x0009 13:52:25 INFO - Displays: 13:52:25 INFO - Display: 13:52:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:52:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:52:25 INFO - Display Serial Number: 1600x1200 60 13:52:25 INFO - Main Display: Yes 13:52:25 INFO - Mirror: Off 13:52:25 INFO - Online: Yes 13:52:25 INFO - Rotation: Supported 13:52:25 INFO - Return code: 0 13:52:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:52:25 INFO - Python 2.7.3 13:52:25 INFO - Return code: 0 13:52:25 INFO - grabbing minidump binary from tooltool 13:52: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')]} 13:52:25 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 0x10ed9bd30>, '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 0x10ebc1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed93b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:52:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:52:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:52:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:52:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:52:25 INFO - Return code: 0 13:52:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:52:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:52:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:52:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:52:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:52:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0080 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:52:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkCX5bdFyJ/Render', 13:52:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:52:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:52:25 INFO - 'HOME': '/Users/cltbld', 13:52:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:52:25 INFO - 'LOGNAME': 'cltbld', 13:52:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:52:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:25 INFO - 'MOZ_NO_REMOTE': '1', 13:52:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:52:25 INFO - 'NO_EM_RESTART': '1', 13:52:25 INFO - 'PAGER': '/bin/cat', 13:52:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:25 INFO - 'PWD': '/builds/slave/test', 13:52:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:52:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:52:25 INFO - 'SHELL': '/bin/bash', 13:52:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8UlWh8poki/Listeners', 13:52:25 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 13:52:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:52:25 INFO - 'USER': 'cltbld', 13:52:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:52:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:25 INFO - 'XPC_FLAGS': '0x0', 13:52:25 INFO - 'XPC_SERVICE_NAME': '0', 13:52:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:52:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:52:25 INFO - mozversion application_buildid: 20161026075526 13:52:25 INFO - mozversion application_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 13:52:25 INFO - mozversion application_display_name: Nightly 13:52:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:52:25 INFO - mozversion application_name: Firefox 13:52:25 INFO - mozversion application_remotingname: firefox 13:52:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:52:25 INFO - mozversion application_vendor: Mozilla 13:52:25 INFO - mozversion application_version: 52.0a1 13:52:25 INFO - mozversion platform_buildid: 20161026075526 13:52:25 INFO - mozversion platform_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 13:52:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:52:25 INFO - mozversion platform_version: 52.0a1 13:52:25 INFO - using testdate: 1477515145 13:52:25 INFO - actual date: 1477515145 13:52:25 INFO - starting webserver on 'localhost:49266' 13:52:25 INFO - SUITE-START | Running 2 tests 13:52:25 INFO - TEST-START | dromaeo_css 13:52:25 INFO - operating with platform_type : mac_ 13:52:25 INFO - Initialising browser for dromaeo_css test... 13:52:25 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpAEUdzJ/profile http://localhost:49266/getInfo.html) 13:52:28 INFO - PROCESS | 1652 | 2016-10-26 13:52:28.318 plugin-container[1655:8489] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b43, name = 'com.apple.tsm.portname' 13:52:28 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:28 INFO - PROCESS | 1652 | 2016-10-26 13:52:28.321 plugin-container[1655:8489] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 13:52:28 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:28 INFO - PROCESS | 1652 | 2016-10-26 13:52:28.321 plugin-container[1655:8489] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:52:28 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 13:52:28 INFO - PROCESS | 1652 | colorDepth:24 13:52:28 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 13:52:28 INFO - PROCESS | 1652 | __metrics 13:52:28 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 13:52:29 INFO - TEST-INFO | 1652: exit 0 13:52:29 INFO - Browser initialized. 13:52:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:52:29 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpAEUdzJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:31 INFO - PROCESS | 1656 | 2016-10-26 13:52:31.750 plugin-container[1657:8603] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 13:52:31 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:31 INFO - PROCESS | 1656 | 2016-10-26 13:52:31.751 plugin-container[1657:8603] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 13:52:31 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:31 INFO - PROCESS | 1656 | 2016-10-26 13:52:31.751 plugin-container[1657:8603] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:52:41 INFO - PROCESS | 1656 | RSS: Main: 236920832 13:52:41 INFO - PROCESS | 1656 | 13:53:31 INFO - PROCESS | 1656 | 1477515211044 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:55:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 13:55:46 INFO - PROCESS | 1656 | RSS: Main: 249409536 13:55:46 INFO - PROCESS | 1656 | 13:58:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 13:58:49 INFO - PROCESS | 1656 | RSS: Main: 261496832 13:58:49 INFO - PROCESS | 1656 | 14:01:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 14:01:51 INFO - PROCESS | 1656 | RSS: Main: 266035200 14:01:51 INFO - PROCESS | 1656 | 14:04:53 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 14:04:54 INFO - PROCESS | 1656 | RSS: Main: 264736768 14:04:54 INFO - PROCESS | 1656 | 14:07:56 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 14:07:57 INFO - PROCESS | 1656 | RSS: Main: 270471168 14:07:57 INFO - PROCESS | 1656 | 14:11:00 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 14:11:00 INFO - PROCESS | 1656 | RSS: Main: 272568320 14:11:00 INFO - PROCESS | 1656 | 14:11:00 INFO - PROCESS | 1656 | __start_tp_report 14:11:00 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 14:11:00 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 14:11:00 INFO - PROCESS | 1656 | |i|pagename|runs| 14:11:00 INFO - PROCESS | 1656 | |0;dojo.html;3376.172837654774;3427.0575591712277;3445.173158441973;3453.740969427293;3459.6194418613964;5759.136129580565;5842.415758424156;5860.120981852724;5948.940510594893;5949.048152295633;5830.212921255629;5882.941170588293;5967.49276311514;6037.064255040465;6060.030395136779;5238.292830467895;5245.921311180336;5333.386660534049;5337.759800808973;5407.756650950697;4658.678399899735;5359.892802143955;5397.7571009304675;5424.5117939385445;5490.094134467808;4586.701864378805;5378.085725426687;5380.690875111778;5415.10650742627;5438.211459338394;5152.819651312224;5221.347331583552;5256.710880901549;5287.9424115176735;5289.603279754034;5184.870378240536;5242.659227150223;5259.342582177228;5261.210818377236;5275.657082289677;4217.514985776645;4591.816327346902;4988.426330971948;5230.241614965808;5732.484076433141;4774.761261936924;4920.901581968376;5259.86850328741;6150.538709596798;6170.167027451282;5673.517750991171;6149.692515374258;6224.657643829588;6315.463185629227;6334.081558174039;4859.562639362474;5772.220750198711;6016.037434010537;6048.969755151196;6057.575969682168;6201.379862013853;6239.78160764371;6471.288158302677;6480;6483.092367068614;6108.827782940766;6120.873812997669;6153.230846144232;6217.191765070603;6220.284667263322;6290.4653104485715;6293.118963345044;6303.464205542488;6327.272363678236;6342.809715708536;5638.379778224392;5813.779106387706;6117.051856962178;6158;6222.160008398899;6090.23872015998;6117.644716737952;6194.783182588588;6247.2815626202655;6253.812385628347;5001.8499445016705;5013.573846223112;5017.67385119966;5052.242163675404;5052.797888084436;3963.7027222957818;4450.3991961085485;4492.146492166478;4505.594496495331;4555.703879247838;4961.5534601886;5894.528437724972;5957.851053723692;5976.73104710289;6073.878522429527;6214.40963108504;6229.408206220402;6235;6258.780942666985;6265.937340626627;6041.577089603686;6062.545309101835;6076.5442591805795;6082.422169893853;6088.512918966472;5539.224508568804;5551.306086739158;5553.389127196006;5568.888622227532;5579.330480342385;6215.751369945242;6354.459870911024;6374.617522948638;6413.1021656969;6512.446442052384;6157.476614487819;6258;6284.214473190851;6322.178116844964;6329.968350158219;6451.838704032437;6516.446102081376;6520.761055399459;6525.412712855866;6534.803955881332;6100.369238098956;6162.044883043135;6184.072389141665;6239.5008399327035;6283.2460104787715;6139.952147134979;6185.474234690102;6336.873262534631;6344.365563443619;6353.809385718436;6118.284172697687;6157.26112866441;6172.598781079216;6187.969060154671;6207.81376558704;6139.246828488627;6139.522803442411;6141.854248382235;6158.661273629993;6217.440430361289;5900.055991041413;6095.238095238095;6095.481884039907;6095.51235901118;6117.174181485442;6170;6174.289956655042;6174.567780255518;6199.969000154971;6228.22147231596;6099.359567245553;6136.846578835565;6146.631202127708;6151.784687535915;6171.47542458896 14:11:00 INFO - PROCESS | 1656 | |1;ext.html;444.986650400488;447.46080972428217;526.3026489900882;533.312027484545;536.951674349309;39390.60609393905;40896.38655420167;40956.79521602395;41106.588934110616;43059.56940430595;31190.2202444939;41810.58189418105;42083;42493.362599561035;42599.36100958488;7644.235576442339;8904.065073167321;9432.764180895463;9598.712038638818;9613.615455381776;9492.193163581103;9508.857367139499;9591.184749296319;9597.76005599862;9611.375260608038;8717.171868672498;9456.8581471278;9532.475713835736;9596.472194029326;9624.615015399411;8015.799605009863;8038.718644847431;8085.676572937075;9196.678116265932;9602.951985240099;9316.906830931672;9441.15029647328;9450;9524.095210955018;9531.38046027006;39297;39371.01572460712;39387.01532461683;39509.60490395088;39547.20905581901;3360.1599600099976;3386.5936087669393;3430.588329400463;3434.1242983039165;3494.842732077037;30101.698983010327;30234.84882575595;30873.610687519114;31229.375412491623;31824.363512729848;3186.6972637599392;3199.680031996805;3227.6288226853744;3314.3371325734947;3350.547676063749;502380;505061.99999999633;506571;506732.932670676;508380;60941;61221.99999999911;61394;61475.07787383193;61695.691521543005;63068.369316307166;64101.11544980394;64196;64255;64561.35438645647;16172.353105875869;16250.024998500128;16377.0173789573;16386.426475073316;16439.26023328953;12464.439100240512;12504.437300321326;12577.24536527793;12599.937000315123;12634.936825316;17598.111033668578;18702;18721.906390468233;18887.905560472384;19085.141168647166;3225.6935591118804;7505.236269476669;7673.424493163036;7866.679329597668;8124.146964568753;868.444195714743;980.7352014955922;991.3902949685892;1016.8474728790741;1035.8290882004535;27806;28874.855625722157;29637.407251854842;29726.851365743034;30146.698533014827;1078.4068762180925;1120.9159313051555;1146.9390813497648;1149.655103468956;1185.5731936502852;14008.579742607739;14282.714345713028;15503;15664.451744189126;15791.605209869846;528503;650340;706978;707888;877224;57803;58226.708866455396;58414.12378814321;58650.12024819631;58781.41218587759;1213.9256757769438;1265.1586694848006;1380.5858242527202;1404.3610157378573;1419.2690764256415;24068;24587.262382128563;27577;30647.896288855165;30760.230994225323;49308.50691493039;49383.76540586514;49600;49967;50148.74925625348;535429;591292;593468;595279;597335;26490.735092648825;26517.734822651528;26770;26840.865795670896;26923;44781.77609112064;45010.87472813206;45332.41336553205;45978.31032534582;46430;37016.444753328185;37352.62647373491;38274.34513097336;38612;38747.41878871876;37282.88151355464;37377.4393384094;37398.439023414125;38448.6155138445;38723.806380967915;36864;37247.255054899295;38222.617773821905;38450;39218.21563568655;30308.696913030588;34157.65842341545;34844;34871.77948771781;34986.65013349834;23441.179558715365;23854.88072559626;25445.745542544337;26056.53862106549;26107.347316317246 14:11:00 INFO - PROCESS | 1656 | |2;jquery.html;371.9367707489725;372.69252866385233;377.54505820486315;380.7334865594085;395.98812035638923;19376.612467750656;20864.687029694567;20910.6863397049;21064.68402973953;21289.893550532226;18879.716804247913;18953.241870325204;19208;19424.125914333854;20690.586188276226;5398.325209348832;5488.670679759207;5522.751476183581;5786.103154011114;5807.448292412214;5392.73036348183;5792.855178620526;5818.941810581903;5831.212786273841;5838.445347691983;5496.422875598065;5513;5695.174199741055;5754.16564598133;5769.884602307951;5654.151877218409;5676.1769543416385;5717.428257174291;5732.971335143339;5733.512651424634;4806.855794326176;4965.478624744386;5007.649464537484;5009.799608015712;5028.698278103326;24596.139135130365;24815.379615509577;25062.24813255605;25215.848018997625;25387.111451099307;1967.2819420911264;2140.122549754609;2344.3787396339985;2487.8928876649716;2549.8980040798533;12011.579594714143;12240.81638775419;15306.540803775793;15456.768148477782;15493.07041577509;1512.780646806207;1775.4939842145056;1844.3821319857864;1917.5302050997454;1945.2705235536673;98768.50615746947;119405;120881;121134;121292;10009;10557.419341936267;11475.483603237873;11514.30914145154;11517.769644607228;13074.150180238254;14188.574342769733;14242.786358204636;14424.639384015274;14475.78286325706;8078.39412044099;8323.916760832315;8367.790805229917;8453.027901791249;8456.915430845613;8223.712170074019;8250.422470427013;8290.212429819157;8452.661893524313;8485.618147183392;4396.670249731283;4566.680332376702;4585.770711464414;4594.632429405639;4703.670743047954;1683.7726906867415;1944.1251436853472;1950.7073938909277;1978.1197367171471;2020.9393718188478;376.14427178169336;377.06864045806816;895.3866601378077;909.6043221198668;951.2770294576172;11431.885681143081;11782.5876094338;11813.054955603531;11937.224080434744;12080.75838483243;376.2550150701626;426.266821067763;435.83873966632547;437.55369523086273;445.2830942183083;5940.524758019348;5956.64260144384;6090.36051214625;6107.755689772359;6115.969420152871;606471;614208;614659;621046;628212.5768113482;127583.36208319085;127917;130759;131652;132399.67600324066;440.73335631942854;448.5917814788527;449.613332534027;449.70094886899847;451.6589974569245;8436.45163064399;11289.37908415045;11339.319640821577;11561.88438115608;11614.361210133186;53578.732106339216;53945.730271348395;53971.46028539664;54165.45834541762;54573.18140227979;75660;79095;79713.60143199247;80027;82305.58847205725;7583.658735357032;7704.730334438268;8041.959790201012;8138.837223255383;8333.583320834055;12224.694382640506;12550.87449125497;12868.292243926673;12911.870881291066;13125.212487250796;9988.800223995624;10148.441835699108;10256;10562.419066951392;10578.735531611772;8121.005581567176;8621;9508.667196648084;9550.044995500672;9579.473128977974;5670.716464176692;8195.67217311301;10303.639372621923;10765.89234107649;10895.945520272347;6120.571559990758;6919.861602768017;7692.9615351922885;7962.920370796218;8126;9797.804043919225;10520.158387328842;10590.099841513558;10891.836622450828;11014.39420831862 14:11:00 INFO - PROCESS | 1656 | |3;mootools.html;1516.6056825225437;1544.3590909772443;1760.4366602687137;1830.4691639424568;1881.2004897918382;7793.1037930637995;8033.558154301526;8337.24964753172;8820.77948051299;8824.95587522063;6437.324080971501;8613.35399845011;8628.482291062524;8737.737867863958;8753.91246087539;2292.896819643112;2303.527776805751;2312.0520586559514;2314;2325.6511523271474;2305.72331320241;2332.4052366646483;2336.556054349668;2356.1871154451687;2357.610994185957;2249.8875056247202;2280.635098384259;2292.64464008079;2312.167619656922;2316.2587971849016;2283.7602051784575;2290.0839664134314;2306.953860922789;2314.953700925989;2319.4665226997718;2318.9420264493524;2326.3951372643064;2333.603287441139;2339.5320935812733;2344.4959333743327;8513;8589.914100858974;8652.3510736695;8690.956545217297;8708.303335733126;5140.614453915934;5270.631055826094;5306.204069389584;5309.707966061865;5313.893722125575;3286.967130328714;3433.5021421893684;3550.5384300041087;3611.747177697562;3620.2759448110482;875.8160786234898;1043.6764602973103;1069.8823129455754;1081.848541204232;1086.7393823165169;11123.388213648246;11273.774524509547;11392.658220253406;11400.315981041163;11476.713082173012;4044.4539987101953;4465.419495465569;4599.08018396322;4684.718916864999;4738.64460165489;9589.849218093874;9715.125638692552;9715.319927605;9724.562394692115;9731.951340243253;5183.352080989876;5194.584433245332;5288.603354748332;5293.364796224478;5297.5232229099565;4330.913381732411;4337.934930975975;4674.252119660838;4735.715857048588;4780;3717.628237176315;3824.2160357126722;3888.241792850367;3909.257241124177;3937.448757173998;1192.3442106841203;1251.5682089679046;1254.9874501255053;1261.993690031544;1269.8634721923827;917.4266083697689;924.9630014799467;945.9688939056462;948.3029972969862;984.5913945712592;5911.467967882825;5927.903337882505;6079.574429789961;6133;6192.442680158717;911.1753862754218;967.8548217767251;986.4278718343344;1000.9099181073739;1029.912457441126;3875.2249550090096;3994.420808982681;4030.6775457963295;4103.076807718239;4105.3020986432375;10071.496425178711;10508.579656813794;10533.524621713892;10534.683959481228;10538.473076346152;10469.84295235572;10493.475326233658;10498.632547860789;10523.52644131016;10559.366438013743;7961.562114083781;8062.1937806220085;8219.753407397788;8221.917780822236;8236.341092712568;4333.761643109533;5314.3091398117995;5615.410381910004;5645.040343141593;5685.516731077904;9150.450972941644;9278.814423711623;9541.856872146784;9625.181859542017;9645.324827262024;7867.724629637935;9715.319927605;9748;9885.406875587487;9907.554160062671;6780.898286525608;6973.686184121828;7301.123865136217;7365.705371785069;7758.456908016385;8015.198480151938;8188.058373287148;8314.833703326021;8331.29184019341;8339.749807505785;7361.521501102411;7394.778156655094;7458.03045604068;7473.364763995121;7497.587632680037;7130.643467826691;7135.785926422008;7284.854302914018;7382.630868456663;7401.33387995083;6817.761378351734;6826.488013398915;6936.271691472322;6946.131733533309;6958.652067396712;4035.4350390944705;4936.136176169084;4994.325766021686;5014.724190169576;5160.535551800356;4975;5000.749962501787;5012.022655582126;5081.364829396325;5216.165413533817 14:11:00 INFO - PROCESS | 1656 | |4;prototype.html;301.2919638848706;309.4028524946853;310.42726170215957;316.6991358209701;317.6775572793615;4914.803407863681;5386.434424385442;5410.83767486975;5444.3194600674915;5457.398117242621;5119.2577076324005;5300.522952934235;5307.893842123155;5312.707801070939;5312.946870531294;3166.7624928130367;3447.9310413791836;3840.5007349044586;3935.783531905744;3977.4829272194575;3194.913729332027;3359.5632567766156;4012.5786792386816;4052.49343832021;4083.2850202914847;4065.3901914712733;4067;4074.2666320062376;4076.9184616307657;4097.213894551704;3523.8766643167623;3951.209758048402;4019.879403617896;4073.327900896363;4092.529359123709;2897.8116422432477;2970.5544168374918;3325.185329594265;3494.8117640002265;3500.824958752052;4036.9394459083137;4145.834166633331;5039.546440820343;5149.459306772772;5189.766460509286;4434.35701823237;4570.680052396334;4614.700044497131;4653.976730116327;4820.30105634681;4979.327790748239;5342.706151161685;5618.073017952033;5622.91565626516;5661.264035675377;3905.3556163233034;3910.980445097785;3928.40899435729;3931.1351502669368;3959.920801583952;5011.373578302712;5905.261842269716;5925.140854576062;5931.584789064767;5941.435563621449;3583.2018060855576;3609.296187243462;3873.4577159197734;3875.418687196887;3902.6682731967535;3932.4297976793205;3960.8019599019935;3975.7018223633345;3977.6643458630233;3981.482407287034;4268.381084742695;4607.815687372535;4630.53694630541;4651.86044418668;4658.906821863611;4975.875603109951;5343.4389389113585;5683.9715801420725;5792.189093526909;5821.970890145522;1138.425095326871;1332.9000324975666;1361.1832900259963;1361.9863801362058;1368.8911981295182;783.8589053970226;816.8938038055134;831.6132998155765;834.649447232164;837.2632083766368;4822;4925.2119660854805;4990.155611301523;5117.74411279442;5431.864203394946;5043;5391.894661594364;5878.441548052928;5906.607823831355;5909;4644.396228490275;4889.853304400874;4985.404670505403;5109.3613298337705;5422.457754224546;2841.6447944007;2991.311998240417;3086.3518661080975;3093.7370323522755;3102.674219206951;5586.636868603528;5750.482456578844;5775.325155704799;5933.3473317934995;6104.550928725256;5129.717865517432;5189.4032186299055;5221.947780522146;5334.253204551366;5993.340732519419;5565.749541270652;5999.790112289904;6037.577369584087;6082.327359975953;6106.969465152646;5046.369203849519;5533.723313834373;5793.275840519935;5846.327672317568;5885.968111843401;4867;5751.986804618517;5820.817193552418;5825.854353641193;5839.708014599338;5100.719460429564;6006.369331220334;6076.422739839708;6079.361667024898;6106.297775755845;3035.9070734535107;3088.3977624363033;3231.951520727144;3367.6463971282665;3402.1494626343415;4067.877963661095;4111.527174374985;4404.757738324295;4482.731036137842;4740.502247263988;4337.1976184405985;4385.649148068083;4766.782421865297;4795.568398844121;4912.631552633496;4019.4372787810316;4232.217039847638;4391.297392417198;4422.302395538654;4770.045990801784;4162.396452514429;4349.78251087438;4713.996551465682;4743;4787.473377928355;4886.434621823571;5359.892802143857;5490.835274941758;5535.114381698909;5648.491635752637;5098.796048158032;5287.8678033047945;5392.245085688085;5526.485449120721;5563.666180029211 14:11:00 INFO - PROCESS | 1656 | |5;yui.html;633.9492840572753;732.5787672088551;743.2196193996305;783.6042798386814;784.5606460382182;14545.490907818228;14944.178070206135;15383.000104993182;15401.383944642228;15410;13914.234717090556;14054.929725351385;14147.434102635882;14175.007749457542;14201.502947396843;708.9432845372357;732.3884556395416;878.6046279174365;880.3749337970049;898.137787723786;861.1775754154799;862.1981557151846;910.4673765846987;915.4553040940663;916.0061333453211;957.2007373842849;961.3366776923936;962.7881865989506;963.2294164668273;964.6720115160844;929.8279818233649;953.8903026151943;955.9904400956005;958.6836344006531;959.0313783079106;679.1985457160548;715.9212486626467;719.0508528742063;719.5215181904027;721.412049179922;14446.422143114263;14476.638084047878;14585.562433127023;14600.926995365062;15177.392904283815;14028.789568156486;14092.506762263272;14277;14318.57044288673;14378.352974116086;11383.829242561369;11584;11590.362530060927;11650.359230242333;11687.357195354252;3732.309522738275;3746.83139258734;3846.0192650873846;3895.14306852492;3937.684985201177;86265.13734862633;88346.23307533814;88612.11387886103;88759.55620221922;90026;10722.517486713117;10783.299085559414;10827.512761925733;10835.295705779099;11269.830952535718;21515;21657.891710541662;21789.782102178775;21844.12623495074;21850.781492185193;7735.883961740578;7805.921940780633;7842.803929901798;7936.047674279123;7937.603119843985;4187.832486700559;4286.892827679333;4311.8490852820005;4345.500267469281;4397.362382454527;3432.8970130896114;3454.274602333488;3540.7698499597445;3542.203004324058;3602.945955810665;652.5334385914094;653.4576301669603;662.0367365483211;663.5056882622381;673.579013116802;636.4399328590903;653.6404977262582;661.983854782906;684.9726010959506;698.3470455124374;8756.610869112254;8929.292727807551;9119.772005699779;9189.678361257324;9258.120478554527;544.4446664402367;583.4020129367433;595.8361450601033;629.3769168523221;665.7170702451439;4243.363495475642;4393.912121757547;4475.216837053503;4511.210538155875;4589.380433641482;98249;108236;111195;112457;115186;78333;82870;83282;102093.48953255186;103409;45209;52416;62459.68770156211;83201.58399208086;84759;7176.341166093432;9795.470964848964;9845;9877.604895804086;9964.701058968243;50179.24731128963;50369.74815125901;53577;55239.17141242804;55283.17075243794;71761;72221.27778722356;73414.26585734288;77368;79019;12690.446674931034;12882.162659427107;12883.742325153631;13010.089293749725;13255.734885302432;12172.57395991136;14061.718765624835;14269.143851368952;14316.427342906167;14812.407503700162;10609.628662996758;13254.403551839998;13268.336583170996;13358.666033349244;13481.932590336986;11497.022753066083;13207.66980825487;13288.601341959757;13408.463661453823;14894.553163405115;9523.61905523799;10175.778906531265;10644.290982896524;13059.934700326437;13418.463261469431;10572.788544229226;11059.72350691239;11215.327080375204;11453.31280123162;11463.770724585629;9323.440593564408;10189.439580823126;10470.947645261725;11456.828147577626;11479.25384849982 14:11:00 INFO - PROCESS | 1656 | __end_tp_report 14:11:00 INFO - PROCESS | 1656 | __start_cc_report 14:11:00 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,360 14:11:00 INFO - PROCESS | 1656 | __end_cc_report 14:11:00 INFO - PROCESS | 1656 | __startTimestamp1477516260496__endTimestamp 14:11:00 INFO - PROCESS | 1656 | 14:11:00 INFO - PROCESS | 1656 | ------- Summary: start ------- 14:11:00 INFO - PROCESS | 1656 | Number of tests: 6 14:11:00 INFO - PROCESS | 1656 | 14:11:00 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5766.27 Median:6090.24 stddev:682.86 (11.2%) stddev-sans-first:658.71 14:11:00 INFO - PROCESS | 1656 | Values: 3376.2 3427.1 3445.2 3453.7 3459.6 5759.1 5842.4 5860.1 5948.9 5949.0 5830.2 5882.9 5967.5 6037.1 6060.0 5238.3 5245.9 5333.4 5337.8 5407.8 4658.7 5359.9 5397.8 5424.5 5490.1 4586.7 5378.1 5380.7 5415.1 5438.2 5152.8 5221.3 5256.7 5287.9 5289.6 5184.9 5242.7 5259.3 5261.2 5275.7 4217.5 4591.8 4988.4 5230.2 5732.5 4774.8 4920.9 5259.9 6150.5 6170.2 5673.5 6149.7 6224.7 6315.5 6334.1 4859.6 5772.2 6016.0 6049.0 6057.6 6201.4 6239.8 6471.3 6480.0 6483.1 6108.8 6120.9 6153.2 6217.2 6220.3 6290.5 6293.1 6303.5 6327.3 6342.8 5638.4 5813.8 6117.1 6158.0 6222.2 6090.2 6117.6 6194.8 6247.3 6253.8 5001.8 5013.6 5017.7 5052.2 5052.8 3963.7 4450.4 4492.1 4505.6 4555.7 4961.6 5894.5 5957.9 5976.7 6073.9 6214.4 6229.4 6235.0 6258.8 6265.9 6041.6 6062.5 6076.5 6082.4 6088.5 5539.2 5551.3 5553.4 5568.9 5579.3 6215.8 6354.5 6374.6 6413.1 6512.4 6157.5 6258.0 6284.2 6322.2 6330.0 6451.8 6516.4 6520.8 6525.4 6534.8 6100.4 6162.0 6184.1 6239.5 6283.2 6140.0 6185.5 6336.9 6344.4 6353.8 6118.3 6157.3 6172.6 6188.0 6207.8 6139.2 6139.5 6141.9 6158.7 6217.4 5900.1 6095.2 6095.5 6095.5 6117.2 6170.0 6174.3 6174.6 6200.0 6228.2 6099.4 6136.8 6146.6 6151.8 6171.5 14:11:00 INFO - PROCESS | 1656 | 14:11:00 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:72086.33 Median:39379.02 stddev:161593.67 (410.4%) stddev-sans-first:161957.46 14:11:00 INFO - PROCESS | 1656 | Values: 445.0 447.5 526.3 533.3 537.0 39390.6 40896.4 40956.8 41106.6 43059.6 31190.2 41810.6 42083.0 42493.4 42599.4 7644.2 8904.1 9432.8 9598.7 9613.6 9492.2 9508.9 9591.2 9597.8 9611.4 8717.2 9456.9 9532.5 9596.5 9624.6 8015.8 8038.7 8085.7 9196.7 9603.0 9316.9 9441.2 9450.0 9524.1 9531.4 39297.0 39371.0 39387.0 39509.6 39547.2 3360.2 3386.6 3430.6 3434.1 3494.8 30101.7 30234.8 30873.6 31229.4 31824.4 3186.7 3199.7 3227.6 3314.3 3350.5 502380.0 505062.0 506571.0 506732.9 508380.0 60941.0 61222.0 61394.0 61475.1 61695.7 63068.4 64101.1 64196.0 64255.0 64561.4 16172.4 16250.0 16377.0 16386.4 16439.3 12464.4 12504.4 12577.2 12599.9 12634.9 17598.1 18702.0 18721.9 18887.9 19085.1 3225.7 7505.2 7673.4 7866.7 8124.1 868.4 980.7 991.4 1016.8 1035.8 27806.0 28874.9 29637.4 29726.9 30146.7 1078.4 1120.9 1146.9 1149.7 1185.6 14008.6 14282.7 15503.0 15664.5 15791.6 528503.0 650340.0 706978.0 707888.0 877224.0 57803.0 58226.7 58414.1 58650.1 58781.4 1213.9 1265.2 1380.6 1404.4 1419.3 24068.0 24587.3 27577.0 30647.9 30760.2 49308.5 49383.8 49600.0 49967.0 50148.7 535429.0 591292.0 593468.0 595279.0 597335.0 26490.7 26517.7 26770.0 26840.9 26923.0 44781.8 45010.9 45332.4 45978.3 46430.0 37016.4 37352.6 38274.3 38612.0 38747.4 37282.9 37377.4 37398.4 38448.6 38723.8 36864.0 37247.3 38222.6 38450.0 39218.2 30308.7 34157.7 34844.0 34871.8 34986.7 23441.2 23854.9 25445.7 26056.5 26107.3 14:11:00 INFO - PROCESS | 1656 | 14:11:00 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:34826.77 Median:2418.70 stddev:103022.73 (4259.4%) stddev-sans-first:103279.25 14:11:00 INFO - PROCESS | 1656 | Values: 371.9 372.7 377.5 380.7 396.0 19376.6 20864.7 20910.7 21064.7 21289.9 18879.7 18953.2 19208.0 19424.1 20690.6 5398.3 5488.7 5522.8 5786.1 5807.4 5392.7 5792.9 5818.9 5831.2 5838.4 5496.4 5513.0 5695.2 5754.2 5769.9 5654.2 5676.2 5717.4 5733.0 5733.5 4806.9 4965.5 5007.6 5009.8 5028.7 24596.1 24815.4 25062.2 25215.8 25387.1 1967.3 2140.1 2344.4 2487.9 2549.9 12011.6 12240.8 15306.5 15456.8 15493.1 1512.8 1775.5 1844.4 1917.5 1945.3 98768.5 119405.0 120881.0 121134.0 121292.0 10009.0 10557.4 11475.5 11514.3 11517.8 13074.2 14188.6 14242.8 14424.6 14475.8 8078.4 8323.9 8367.8 8453.0 8456.9 8223.7 8250.4 8290.2 8452.7 8485.6 4396.7 4566.7 4585.8 4594.6 4703.7 1683.8 1944.1 1950.7 1978.1 2020.9 376.1 377.1 895.4 909.6 951.3 11431.9 11782.6 11813.1 11937.2 12080.8 376.3 426.3 435.8 437.6 445.3 5940.5 5956.6 6090.4 6107.8 6116.0 606471.0 614208.0 614659.0 621046.0 628212.6 127583.4 127917.0 130759.0 131652.0 132399.7 440.7 448.6 449.6 449.7 451.7 8436.5 11289.4 11339.3 11561.9 11614.4 53578.7 53945.7 53971.5 54165.5 54573.2 75660.0 79095.0 79713.6 80027.0 82305.6 7583.7 7704.7 8042.0 8138.8 8333.6 12224.7 12550.9 12868.3 12911.9 13125.2 9988.8 10148.4 10256.0 10562.4 10578.7 8121.0 8621.0 9508.7 9550.0 9579.5 5670.7 8195.7 10303.6 10765.9 10895.9 6120.6 6919.9 7693.0 7962.9 8126.0 9797.8 10520.2 10590.1 10891.8 11014.4 14:11:00 INFO - PROCESS | 1656 | 14:11:00 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5583.34 Median:5150.58 stddev:3092.12 (60.0%) stddev-sans-first:3085.69 14:11:00 INFO - PROCESS | 1656 | Values: 1516.6 1544.4 1760.4 1830.5 1881.2 7793.1 8033.6 8337.2 8820.8 8825.0 6437.3 8613.4 8628.5 8737.7 8753.9 2292.9 2303.5 2312.1 2314.0 2325.7 2305.7 2332.4 2336.6 2356.2 2357.6 2249.9 2280.6 2292.6 2312.2 2316.3 2283.8 2290.1 2307.0 2315.0 2319.5 2318.9 2326.4 2333.6 2339.5 2344.5 8513.0 8589.9 8652.4 8691.0 8708.3 5140.6 5270.6 5306.2 5309.7 5313.9 3287.0 3433.5 3550.5 3611.7 3620.3 875.8 1043.7 1069.9 1081.8 1086.7 11123.4 11273.8 11392.7 11400.3 11476.7 4044.5 4465.4 4599.1 4684.7 4738.6 9589.8 9715.1 9715.3 9724.6 9732.0 5183.4 5194.6 5288.6 5293.4 5297.5 4330.9 4337.9 4674.3 4735.7 4780.0 3717.6 3824.2 3888.2 3909.3 3937.4 1192.3 1251.6 1255.0 1262.0 1269.9 917.4 925.0 946.0 948.3 984.6 5911.5 5927.9 6079.6 6133.0 6192.4 911.2 967.9 986.4 1000.9 1029.9 3875.2 3994.4 4030.7 4103.1 4105.3 10071.5 10508.6 10533.5 10534.7 10538.5 10469.8 10493.5 10498.6 10523.5 10559.4 7961.6 8062.2 8219.8 8221.9 8236.3 4333.8 5314.3 5615.4 5645.0 5685.5 9150.5 9278.8 9541.9 9625.2 9645.3 7867.7 9715.3 9748.0 9885.4 9907.6 6780.9 6973.7 7301.1 7365.7 7758.5 8015.2 8188.1 8314.8 8331.3 8339.7 7361.5 7394.8 7458.0 7473.4 7497.6 7130.6 7135.8 7284.9 7382.6 7401.3 6817.8 6826.5 6936.3 6946.1 6958.7 4035.4 4936.1 4994.3 5014.7 5160.5 4975.0 5000.7 5012.0 5081.4 5216.2 14:11:00 INFO - PROCESS | 1656 | 14:11:00 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4412.88 Median:4807.93 stddev:1386.31 (28.8%) stddev-sans-first:1355.41 14:11:00 INFO - PROCESS | 1656 | Values: 301.3 309.4 310.4 316.7 317.7 4914.8 5386.4 5410.8 5444.3 5457.4 5119.3 5300.5 5307.9 5312.7 5312.9 3166.8 3447.9 3840.5 3935.8 3977.5 3194.9 3359.6 4012.6 4052.5 4083.3 4065.4 4067.0 4074.3 4076.9 4097.2 3523.9 3951.2 4019.9 4073.3 4092.5 2897.8 2970.6 3325.2 3494.8 3500.8 4036.9 4145.8 5039.5 5149.5 5189.8 4434.4 4570.7 4614.7 4654.0 4820.3 4979.3 5342.7 5618.1 5622.9 5661.3 3905.4 3911.0 3928.4 3931.1 3959.9 5011.4 5905.3 5925.1 5931.6 5941.4 3583.2 3609.3 3873.5 3875.4 3902.7 3932.4 3960.8 3975.7 3977.7 3981.5 4268.4 4607.8 4630.5 4651.9 4658.9 4975.9 5343.4 5684.0 5792.2 5822.0 1138.4 1332.9 1361.2 1362.0 1368.9 783.9 816.9 831.6 834.6 837.3 4822.0 4925.2 4990.2 5117.7 5431.9 5043.0 5391.9 5878.4 5906.6 5909.0 4644.4 4889.9 4985.4 5109.4 5422.5 2841.6 2991.3 3086.4 3093.7 3102.7 5586.6 5750.5 5775.3 5933.3 6104.6 5129.7 5189.4 5221.9 5334.3 5993.3 5565.7 5999.8 6037.6 6082.3 6107.0 5046.4 5533.7 5793.3 5846.3 5886.0 4867.0 5752.0 5820.8 5825.9 5839.7 5100.7 6006.4 6076.4 6079.4 6106.3 3035.9 3088.4 3232.0 3367.6 3402.1 4067.9 4111.5 4404.8 4482.7 4740.5 4337.2 4385.6 4766.8 4795.6 4912.6 4019.4 4232.2 4391.3 4422.3 4770.0 4162.4 4349.8 4714.0 4743.0 4787.5 4886.4 5359.9 5490.8 5535.1 5648.5 5098.8 5287.9 5392.2 5526.5 5563.7 14:11:00 INFO - PROCESS | 1656 | 14:11:00 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:19956.37 Median:4436.29 stddev:28719.90 (647.4%) stddev-sans-first:28763.82 14:11:00 INFO - PROCESS | 1656 | Values: 633.9 732.6 743.2 783.6 784.6 14545.5 14944.2 15383.0 15401.4 15410.0 13914.2 14054.9 14147.4 14175.0 14201.5 708.9 732.4 878.6 880.4 898.1 861.2 862.2 910.5 915.5 916.0 957.2 961.3 962.8 963.2 964.7 929.8 953.9 956.0 958.7 959.0 679.2 715.9 719.1 719.5 721.4 14446.4 14476.6 14585.6 14600.9 15177.4 14028.8 14092.5 14277.0 14318.6 14378.4 11383.8 11584.0 11590.4 11650.4 11687.4 3732.3 3746.8 3846.0 3895.1 3937.7 86265.1 88346.2 88612.1 88759.6 90026.0 10722.5 10783.3 10827.5 10835.3 11269.8 21515.0 21657.9 21789.8 21844.1 21850.8 7735.9 7805.9 7842.8 7936.0 7937.6 4187.8 4286.9 4311.8 4345.5 4397.4 3432.9 3454.3 3540.8 3542.2 3602.9 652.5 653.5 662.0 663.5 673.6 636.4 653.6 662.0 685.0 698.3 8756.6 8929.3 9119.8 9189.7 9258.1 544.4 583.4 595.8 629.4 665.7 4243.4 4393.9 4475.2 4511.2 4589.4 98249.0 108236.0 111195.0 112457.0 115186.0 78333.0 82870.0 83282.0 102093.5 103409.0 45209.0 52416.0 62459.7 83201.6 84759.0 7176.3 9795.5 9845.0 9877.6 9964.7 50179.2 50369.7 53577.0 55239.2 55283.2 71761.0 72221.3 73414.3 77368.0 79019.0 12690.4 12882.2 12883.7 13010.1 13255.7 12172.6 14061.7 14269.1 14316.4 14812.4 10609.6 13254.4 13268.3 13358.7 13481.9 11497.0 13207.7 13288.6 13408.5 14894.6 9523.6 10175.8 10644.3 13059.9 13418.5 10572.8 11059.7 11215.3 11453.3 11463.8 9323.4 10189.4 10470.9 11456.8 11479.3 14:11:00 INFO - PROCESS | 1656 | -------- Summary: end -------- 14:11:00 INFO - PROCESS | 1656 | 14:11:01 INFO - TEST-INFO | 1656: exit 0 14:11:01 INFO - TEST-OK | dromaeo_css | took 1115631ms 14:11:01 INFO - TEST-START | kraken 14:11:01 INFO - operating with platform_type : mac_ 14:11:01 INFO - Initialising browser for kraken test... 14:11:01 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmp7Iu7Dt/profile http://localhost:49266/getInfo.html) 14:11:04 INFO - PROCESS | 1667 | 2016-10-26 14:11:04.038 plugin-container[1668:11041] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883b, name = 'com.apple.tsm.portname' 14:11:04 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:11:04 INFO - PROCESS | 1667 | 2016-10-26 14:11:04.041 plugin-container[1668:11041] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 14:11:04 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:11:04 INFO - PROCESS | 1667 | 2016-10-26 14:11:04.041 plugin-container[1668:11041] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:11:04 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 14:11:04 INFO - PROCESS | 1667 | colorDepth:24 14:11:04 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 14:11:04 INFO - PROCESS | 1667 | __metrics 14:11:04 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 14:11:04 INFO - TEST-INFO | 1667: exit 0 14:11:04 INFO - Browser initialized. 14:11:04 INFO - Running cycle 1/1 for kraken test... 14:11:04 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmp7Iu7Dt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:07 INFO - PROCESS | 1669 | 2016-10-26 14:11:07.265 plugin-container[1670:11155] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x862b, name = 'com.apple.tsm.portname' 14:11:07 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:11:07 INFO - PROCESS | 1669 | 2016-10-26 14:11:07.265 plugin-container[1670:11155] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 14:11:07 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:11:07 INFO - PROCESS | 1669 | 2016-10-26 14:11:07.265 plugin-container[1670:11155] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:11:16 INFO - PROCESS | 1669 | RSS: Main: 236826624 14:11:16 INFO - PROCESS | 1669 | 14:11:19 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 14:11:20 INFO - PROCESS | 1669 | RSS: Main: 249196544 14:11:20 INFO - PROCESS | 1669 | 14:11:23 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 14:11:23 INFO - PROCESS | 1669 | RSS: Main: 256753664 14:11:23 INFO - PROCESS | 1669 | 14:11:27 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 14:11:27 INFO - PROCESS | 1669 | RSS: Main: 259584000 14:11:27 INFO - PROCESS | 1669 | 14:11:29 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 14:11:30 INFO - PROCESS | 1669 | RSS: Main: 262078464 14:11:30 INFO - PROCESS | 1669 | 14:11:32 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:11:33 INFO - PROCESS | 1669 | RSS: Main: 262127616 14:11:33 INFO - PROCESS | 1669 | 14:11:35 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 14:11:36 INFO - PROCESS | 1669 | RSS: Main: 263467008 14:11:36 INFO - PROCESS | 1669 | 14:11:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 14:11:40 INFO - PROCESS | 1669 | RSS: Main: 263196672 14:11:40 INFO - PROCESS | 1669 | 14:11:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 14:11:43 INFO - PROCESS | 1669 | RSS: Main: 263688192 14:11:43 INFO - PROCESS | 1669 | 14:11:45 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:11:46 INFO - PROCESS | 1669 | RSS: Main: 263385088 14:11:46 INFO - PROCESS | 1669 | 14:11:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:11:48 INFO - PROCESS | 1669 | RSS: Main: 263450624 14:11:48 INFO - PROCESS | 1669 | 14:11:50 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:11:51 INFO - PROCESS | 1669 | RSS: Main: 263557120 14:11:51 INFO - PROCESS | 1669 | 14:11:54 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:11:55 INFO - PROCESS | 1669 | RSS: Main: 263876608 14:11:55 INFO - PROCESS | 1669 | 14:11:58 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:11:59 INFO - PROCESS | 1669 | RSS: Main: 263933952 14:11:59 INFO - PROCESS | 1669 | 14:12:00 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 14:12:01 INFO - PROCESS | 1669 | RSS: Main: 265236480 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | __start_tp_report 14:12:01 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 14:12:01 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 14:12:01 INFO - PROCESS | 1669 | |i|pagename|runs| 14:12:01 INFO - PROCESS | 1669 | |0;ai-astar;111;119;118;137;172;152;118;121;139;173 14:12:01 INFO - PROCESS | 1669 | |1;audio-beat-detection;148;121;100;181;142;147;116;113;143;115 14:12:01 INFO - PROCESS | 1669 | |2;audio-dft;195;199;206;239;197;201;203;236;196;193 14:12:01 INFO - PROCESS | 1669 | |3;audio-fft;73;59;60;80;61;72;82;58;87;84 14:12:01 INFO - PROCESS | 1669 | |4;audio-oscillator;87;70;85;73;70;70;91;100;79;122 14:12:01 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;121;126;90;88;91;86;89;87;89;86 14:12:01 INFO - PROCESS | 1669 | |6;imaging-darkroom;101;107;101;100;103;100;100;100;137;120 14:12:01 INFO - PROCESS | 1669 | |7;imaging-desaturate;87;138;137;90;86;88;93;142;77;135 14:12:01 INFO - PROCESS | 1669 | |8;json-parse-financial;49;48;48;51;78;82;90;89;88;85 14:12:01 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;67;74;71;78;74;70;68;68;86;74 14:12:01 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;91;92;84;87;81;92;112;90;90;94 14:12:01 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;166;165;144;148;152;163;167;143;191;150 14:12:01 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;182;175;174;174;174;176;177;218;244;242 14:12:01 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;71;69;69;71;73;71;70;67;77;95 14:12:01 INFO - PROCESS | 1669 | __end_tp_report 14:12:01 INFO - PROCESS | 1669 | __start_cc_report 14:12:01 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,937 14:12:01 INFO - PROCESS | 1669 | __end_cc_report 14:12:01 INFO - PROCESS | 1669 | __startTimestamp1477516321116__endTimestamp 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | ------- Summary: start ------- 14:12:01 INFO - PROCESS | 1669 | Number of tests: 14 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:136.00 Median:138.00 stddev:22.90 (16.6%) stddev-sans-first:22.43 14:12:01 INFO - PROCESS | 1669 | Values: 111.0 119.0 118.0 137.0 172.0 152.0 118.0 121.0 139.0 173.0 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:142.50 stddev:23.92 (16.8%) stddev-sans-first:24.72 14:12:01 INFO - PROCESS | 1669 | Values: 148.0 121.0 100.0 181.0 142.0 147.0 116.0 113.0 143.0 115.0 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:206.50 Median:202.00 stddev:16.80 (8.3%) stddev-sans-first:17.30 14:12:01 INFO - PROCESS | 1669 | Values: 195.0 199.0 206.0 239.0 197.0 201.0 203.0 236.0 196.0 193.0 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:71.60 Median:76.50 stddev:11.36 (14.9%) stddev-sans-first:12.04 14:12:01 INFO - PROCESS | 1669 | Values: 73.0 59.0 60.0 80.0 61.0 72.0 82.0 58.0 87.0 84.0 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:84.70 Median:76.00 stddev:16.63 (21.9%) stddev-sans-first:17.61 14:12:01 INFO - PROCESS | 1669 | Values: 87.0 70.0 85.0 73.0 70.0 70.0 91.0 100.0 79.0 122.0 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:95.30 Median:88.50 stddev:15.00 (16.9%) stddev-sans-first:12.70 14:12:01 INFO - PROCESS | 1669 | Values: 121.0 126.0 90.0 88.0 91.0 86.0 89.0 87.0 89.0 86.0 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:106.90 Median:102.00 stddev:12.26 (12.0%) stddev-sans-first:12.82 14:12:01 INFO - PROCESS | 1669 | Values: 101.0 107.0 101.0 100.0 103.0 100.0 100.0 100.0 137.0 120.0 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:107.30 Median:86.50 stddev:26.78 (31.0%) stddev-sans-first:27.38 14:12:01 INFO - PROCESS | 1669 | Values: 87.0 138.0 137.0 90.0 86.0 88.0 93.0 142.0 77.0 135.0 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:70.80 Median:83.50 stddev:19.10 (22.9%) stddev-sans-first:18.55 14:12:01 INFO - PROCESS | 1669 | Values: 49.0 48.0 48.0 51.0 78.0 82.0 90.0 89.0 88.0 85.0 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:73.00 Median:74.00 stddev:5.73 (7.7%) stddev-sans-first:5.66 14:12:01 INFO - PROCESS | 1669 | Values: 67.0 74.0 71.0 78.0 74.0 70.0 68.0 68.0 86.0 74.0 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:90.50 stddev:8.29 (9.2%) stddev-sans-first:8.79 14:12:01 INFO - PROCESS | 1669 | Values: 91.0 92.0 84.0 87.0 81.0 92.0 112.0 90.0 90.0 94.0 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:158.90 Median:164.00 stddev:14.61 (8.9%) stddev-sans-first:15.27 14:12:01 INFO - PROCESS | 1669 | Values: 166.0 165.0 144.0 148.0 152.0 163.0 167.0 143.0 191.0 150.0 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.60 Median:179.50 stddev:29.24 (16.3%) stddev-sans-first:30.71 14:12:01 INFO - PROCESS | 1669 | Values: 182.0 175.0 174.0 174.0 174.0 176.0 177.0 218.0 244.0 242.0 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:71.00 stddev:8.08 (11.4%) stddev-sans-first:8.53 14:12:01 INFO - PROCESS | 1669 | Values: 71.0 69.0 69.0 71.0 73.0 71.0 70.0 67.0 77.0 95.0 14:12:01 INFO - PROCESS | 1669 | -------- Summary: end -------- 14:12:01 INFO - PROCESS | 1669 | 14:12:01 INFO - TEST-INFO | 1669: exit 0 14:12:01 INFO - TEST-OK | kraken | took 60829ms 14:12:01 INFO - SUITE-END | took 1176s 14:12:02 INFO - Completed test suite (00:19:36) 14:12:02 INFO - javascript benchmark 14:12:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7097.093620899374, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3376.172837654774, 3427.0575591712277, 3445.173158441973, 3453.740969427293, 3459.6194418613964, 5759.136129580565, 5842.415758424156, 5860.120981852724, 5948.940510594893, 5949.048152295633, 5830.212921255629, 5882.941170588293, 5967.49276311514, 6037.064255040465, 6060.030395136779, 5238.292830467895, 5245.921311180336, 5333.386660534049, 5337.759800808973, 5407.756650950697, 4658.678399899735, 5359.892802143955, 5397.7571009304675, 5424.5117939385445, 5490.094134467808, 4586.701864378805, 5378.085725426687, 5380.690875111778, 5415.10650742627, 5438.211459338394, 5152.819651312224, 5221.347331583552, 5256.710880901549, 5287.9424115176735, 5289.603279754034, 5184.870378240536, 5242.659227150223, 5259.342582177228, 5261.210818377236, 5275.657082289677, 4217.514985776645, 4591.816327346902, 4988.426330971948, 5230.241614965808, 5732.484076433141, 4774.761261936924, 4920.901581968376, 5259.86850328741, 6150.538709596798, 6170.167027451282, 5673.517750991171, 6149.692515374258, 6224.657643829588, 6315.463185629227, 6334.081558174039, 4859.562639362474, 5772.220750198711, 6016.037434010537, 6048.969755151196, 6057.575969682168, 6201.379862013853, 6239.78160764371, 6471.288158302677, 6480.0, 6483.092367068614, 6108.827782940766, 6120.873812997669, 6153.230846144232, 6217.191765070603, 6220.284667263322, 6290.4653104485715, 6293.118963345044, 6303.464205542488, 6327.272363678236, 6342.809715708536, 5638.379778224392, 5813.779106387706, 6117.051856962178, 6158.0, 6222.160008398899, 6090.23872015998, 6117.644716737952, 6194.783182588588, 6247.2815626202655, 6253.812385628347, 5001.8499445016705, 5013.573846223112, 5017.67385119966, 5052.242163675404, 5052.797888084436, 3963.7027222957818, 4450.3991961085485, 4492.146492166478, 4505.594496495331, 4555.703879247838, 4961.5534601886, 5894.528437724972, 5957.851053723692, 5976.73104710289, 6073.878522429527, 6214.40963108504, 6229.408206220402, 6235.0, 6258.780942666985, 6265.937340626627, 6041.577089603686, 6062.545309101835, 6076.5442591805795, 6082.422169893853, 6088.512918966472, 5539.224508568804, 5551.306086739158, 5553.389127196006, 5568.888622227532, 5579.330480342385, 6215.751369945242, 6354.459870911024, 6374.617522948638, 6413.1021656969, 6512.446442052384, 6157.476614487819, 6258.0, 6284.214473190851, 6322.178116844964, 6329.968350158219, 6451.838704032437, 6516.446102081376, 6520.761055399459, 6525.412712855866, 6534.803955881332, 6100.369238098956, 6162.044883043135, 6184.072389141665, 6239.5008399327035, 6283.2460104787715, 6139.952147134979, 6185.474234690102, 6336.873262534631, 6344.365563443619, 6353.809385718436, 6118.284172697687, 6157.26112866441, 6172.598781079216, 6187.969060154671, 6207.81376558704, 6139.246828488627, 6139.522803442411, 6141.854248382235, 6158.661273629993, 6217.440430361289, 5900.055991041413, 6095.238095238095, 6095.481884039907, 6095.51235901118, 6117.174181485442, 6170.0, 6174.289956655042, 6174.567780255518, 6199.969000154971, 6228.22147231596, 6099.359567245553, 6136.846578835565, 6146.631202127708, 6151.784687535915, 6171.47542458896], "value": 5723.494717248619, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.986650400488, 447.46080972428217, 526.3026489900882, 533.312027484545, 536.951674349309, 39390.60609393905, 40896.38655420167, 40956.79521602395, 41106.588934110616, 43059.56940430595, 31190.2202444939, 41810.58189418105, 42083.0, 42493.362599561035, 42599.36100958488, 7644.235576442339, 8904.065073167321, 9432.764180895463, 9598.712038638818, 9613.615455381776, 9492.193163581103, 9508.857367139499, 9591.184749296319, 9597.76005599862, 9611.375260608038, 8717.171868672498, 9456.8581471278, 9532.475713835736, 9596.472194029326, 9624.615015399411, 8015.799605009863, 8038.718644847431, 8085.676572937075, 9196.678116265932, 9602.951985240099, 9316.906830931672, 9441.15029647328, 9450.0, 9524.095210955018, 9531.38046027006, 39297.0, 39371.01572460712, 39387.01532461683, 39509.60490395088, 39547.20905581901, 3360.1599600099976, 3386.5936087669393, 3430.588329400463, 3434.1242983039165, 3494.842732077037, 30101.698983010327, 30234.84882575595, 30873.610687519114, 31229.375412491623, 31824.363512729848, 3186.6972637599392, 3199.680031996805, 3227.6288226853744, 3314.3371325734947, 3350.547676063749, 502380.0, 505061.99999999633, 506571.0, 506732.932670676, 508380.0, 60941.0, 61221.99999999911, 61394.0, 61475.07787383193, 61695.691521543005, 63068.369316307166, 64101.11544980394, 64196.0, 64255.0, 64561.35438645647, 16172.353105875869, 16250.024998500128, 16377.0173789573, 16386.426475073316, 16439.26023328953, 12464.439100240512, 12504.437300321326, 12577.24536527793, 12599.937000315123, 12634.936825316, 17598.111033668578, 18702.0, 18721.906390468233, 18887.905560472384, 19085.141168647166, 3225.6935591118804, 7505.236269476669, 7673.424493163036, 7866.679329597668, 8124.146964568753, 868.444195714743, 980.7352014955922, 991.3902949685892, 1016.8474728790741, 1035.8290882004535, 27806.0, 28874.855625722157, 29637.407251854842, 29726.851365743034, 30146.698533014827, 1078.4068762180925, 1120.9159313051555, 1146.9390813497648, 1149.655103468956, 1185.5731936502852, 14008.579742607739, 14282.714345713028, 15503.0, 15664.451744189126, 15791.605209869846, 528503.0, 650340.0, 706978.0, 707888.0, 877224.0, 57803.0, 58226.708866455396, 58414.12378814321, 58650.12024819631, 58781.41218587759, 1213.9256757769438, 1265.1586694848006, 1380.5858242527202, 1404.3610157378573, 1419.2690764256415, 24068.0, 24587.262382128563, 27577.0, 30647.896288855165, 30760.230994225323, 49308.50691493039, 49383.76540586514, 49600.0, 49967.0, 50148.74925625348, 535429.0, 591292.0, 593468.0, 595279.0, 597335.0, 26490.735092648825, 26517.734822651528, 26770.0, 26840.865795670896, 26923.0, 44781.77609112064, 45010.87472813206, 45332.41336553205, 45978.31032534582, 46430.0, 37016.444753328185, 37352.62647373491, 38274.34513097336, 38612.0, 38747.41878871876, 37282.88151355464, 37377.4393384094, 37398.439023414125, 38448.6155138445, 38723.806380967915, 36864.0, 37247.255054899295, 38222.617773821905, 38450.0, 39218.21563568655, 30308.696913030588, 34157.65842341545, 34844.0, 34871.77948771781, 34986.65013349834, 23441.179558715365, 23854.88072559626, 25445.745542544337, 26056.53862106549, 26107.347316317246], "value": 19770.315161174207, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.9367707489725, 372.69252866385233, 377.54505820486315, 380.7334865594085, 395.98812035638923, 19376.612467750656, 20864.687029694567, 20910.6863397049, 21064.68402973953, 21289.893550532226, 18879.716804247913, 18953.241870325204, 19208.0, 19424.125914333854, 20690.586188276226, 5398.325209348832, 5488.670679759207, 5522.751476183581, 5786.103154011114, 5807.448292412214, 5392.73036348183, 5792.855178620526, 5818.941810581903, 5831.212786273841, 5838.445347691983, 5496.422875598065, 5513.0, 5695.174199741055, 5754.16564598133, 5769.884602307951, 5654.151877218409, 5676.1769543416385, 5717.428257174291, 5732.971335143339, 5733.512651424634, 4806.855794326176, 4965.478624744386, 5007.649464537484, 5009.799608015712, 5028.698278103326, 24596.139135130365, 24815.379615509577, 25062.24813255605, 25215.848018997625, 25387.111451099307, 1967.2819420911264, 2140.122549754609, 2344.3787396339985, 2487.8928876649716, 2549.8980040798533, 12011.579594714143, 12240.81638775419, 15306.540803775793, 15456.768148477782, 15493.07041577509, 1512.780646806207, 1775.4939842145056, 1844.3821319857864, 1917.5302050997454, 1945.2705235536673, 98768.50615746947, 119405.0, 120881.0, 121134.0, 121292.0, 10009.0, 10557.419341936267, 11475.483603237873, 11514.30914145154, 11517.769644607228, 13074.150180238254, 14188.574342769733, 14242.786358204636, 14424.639384015274, 14475.78286325706, 8078.39412044099, 8323.916760832315, 8367.790805229917, 8453.027901791249, 8456.915430845613, 8223.712170074019, 8250.422470427013, 8290.212429819157, 8452.661893524313, 8485.618147183392, 4396.670249731283, 4566.680332376702, 4585.770711464414, 4594.632429405639, 4703.670743047954, 1683.7726906867415, 1944.1251436853472, 1950.7073938909277, 1978.1197367171471, 2020.9393718188478, 376.14427178169336, 377.06864045806816, 895.3866601378077, 909.6043221198668, 951.2770294576172, 11431.885681143081, 11782.5876094338, 11813.054955603531, 11937.224080434744, 12080.75838483243, 376.2550150701626, 426.266821067763, 435.83873966632547, 437.55369523086273, 445.2830942183083, 5940.524758019348, 5956.64260144384, 6090.36051214625, 6107.755689772359, 6115.969420152871, 606471.0, 614208.0, 614659.0, 621046.0, 628212.5768113482, 127583.36208319085, 127917.0, 130759.0, 131652.0, 132399.67600324066, 440.73335631942854, 448.5917814788527, 449.613332534027, 449.70094886899847, 451.6589974569245, 8436.45163064399, 11289.37908415045, 11339.319640821577, 11561.88438115608, 11614.361210133186, 53578.732106339216, 53945.730271348395, 53971.46028539664, 54165.45834541762, 54573.18140227979, 75660.0, 79095.0, 79713.60143199247, 80027.0, 82305.58847205725, 7583.658735357032, 7704.730334438268, 8041.959790201012, 8138.837223255383, 8333.583320834055, 12224.694382640506, 12550.87449125497, 12868.292243926673, 12911.870881291066, 13125.212487250796, 9988.800223995624, 10148.441835699108, 10256.0, 10562.419066951392, 10578.735531611772, 8121.005581567176, 8621.0, 9508.667196648084, 9550.044995500672, 9579.473128977974, 5670.716464176692, 8195.67217311301, 10303.639372621923, 10765.89234107649, 10895.945520272347, 6120.571559990758, 6919.861602768017, 7692.9615351922885, 7962.920370796218, 8126.0, 9797.804043919225, 10520.158387328842, 10590.099841513558, 10891.836622450828, 11014.39420831862], "value": 8513.26372204731, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.6056825225437, 1544.3590909772443, 1760.4366602687137, 1830.4691639424568, 1881.2004897918382, 7793.1037930637995, 8033.558154301526, 8337.24964753172, 8820.77948051299, 8824.95587522063, 6437.324080971501, 8613.35399845011, 8628.482291062524, 8737.737867863958, 8753.91246087539, 2292.896819643112, 2303.527776805751, 2312.0520586559514, 2314.0, 2325.6511523271474, 2305.72331320241, 2332.4052366646483, 2336.556054349668, 2356.1871154451687, 2357.610994185957, 2249.8875056247202, 2280.635098384259, 2292.64464008079, 2312.167619656922, 2316.2587971849016, 2283.7602051784575, 2290.0839664134314, 2306.953860922789, 2314.953700925989, 2319.4665226997718, 2318.9420264493524, 2326.3951372643064, 2333.603287441139, 2339.5320935812733, 2344.4959333743327, 8513.0, 8589.914100858974, 8652.3510736695, 8690.956545217297, 8708.303335733126, 5140.614453915934, 5270.631055826094, 5306.204069389584, 5309.707966061865, 5313.893722125575, 3286.967130328714, 3433.5021421893684, 3550.5384300041087, 3611.747177697562, 3620.2759448110482, 875.8160786234898, 1043.6764602973103, 1069.8823129455754, 1081.848541204232, 1086.7393823165169, 11123.388213648246, 11273.774524509547, 11392.658220253406, 11400.315981041163, 11476.713082173012, 4044.4539987101953, 4465.419495465569, 4599.08018396322, 4684.718916864999, 4738.64460165489, 9589.849218093874, 9715.125638692552, 9715.319927605, 9724.562394692115, 9731.951340243253, 5183.352080989876, 5194.584433245332, 5288.603354748332, 5293.364796224478, 5297.5232229099565, 4330.913381732411, 4337.934930975975, 4674.252119660838, 4735.715857048588, 4780.0, 3717.628237176315, 3824.2160357126722, 3888.241792850367, 3909.257241124177, 3937.448757173998, 1192.3442106841203, 1251.5682089679046, 1254.9874501255053, 1261.993690031544, 1269.8634721923827, 917.4266083697689, 924.9630014799467, 945.9688939056462, 948.3029972969862, 984.5913945712592, 5911.467967882825, 5927.903337882505, 6079.574429789961, 6133.0, 6192.442680158717, 911.1753862754218, 967.8548217767251, 986.4278718343344, 1000.9099181073739, 1029.912457441126, 3875.2249550090096, 3994.420808982681, 4030.6775457963295, 4103.076807718239, 4105.3020986432375, 10071.496425178711, 10508.579656813794, 10533.524621713892, 10534.683959481228, 10538.473076346152, 10469.84295235572, 10493.475326233658, 10498.632547860789, 10523.52644131016, 10559.366438013743, 7961.562114083781, 8062.1937806220085, 8219.753407397788, 8221.917780822236, 8236.341092712568, 4333.761643109533, 5314.3091398117995, 5615.410381910004, 5645.040343141593, 5685.516731077904, 9150.450972941644, 9278.814423711623, 9541.856872146784, 9625.181859542017, 9645.324827262024, 7867.724629637935, 9715.319927605, 9748.0, 9885.406875587487, 9907.554160062671, 6780.898286525608, 6973.686184121828, 7301.123865136217, 7365.705371785069, 7758.456908016385, 8015.198480151938, 8188.058373287148, 8314.833703326021, 8331.29184019341, 8339.749807505785, 7361.521501102411, 7394.778156655094, 7458.03045604068, 7473.364763995121, 7497.587632680037, 7130.643467826691, 7135.785926422008, 7284.854302914018, 7382.630868456663, 7401.33387995083, 6817.761378351734, 6826.488013398915, 6936.271691472322, 6946.131733533309, 6958.652067396712, 4035.4350390944705, 4936.136176169084, 4994.325766021686, 5014.724190169576, 5160.535551800356, 4975.0, 5000.749962501787, 5012.022655582126, 5081.364829396325, 5216.165413533817], "value": 4518.1204972524765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.2919638848706, 309.4028524946853, 310.42726170215957, 316.6991358209701, 317.6775572793615, 4914.803407863681, 5386.434424385442, 5410.83767486975, 5444.3194600674915, 5457.398117242621, 5119.2577076324005, 5300.522952934235, 5307.893842123155, 5312.707801070939, 5312.946870531294, 3166.7624928130367, 3447.9310413791836, 3840.5007349044586, 3935.783531905744, 3977.4829272194575, 3194.913729332027, 3359.5632567766156, 4012.5786792386816, 4052.49343832021, 4083.2850202914847, 4065.3901914712733, 4067.0, 4074.2666320062376, 4076.9184616307657, 4097.213894551704, 3523.8766643167623, 3951.209758048402, 4019.879403617896, 4073.327900896363, 4092.529359123709, 2897.8116422432477, 2970.5544168374918, 3325.185329594265, 3494.8117640002265, 3500.824958752052, 4036.9394459083137, 4145.834166633331, 5039.546440820343, 5149.459306772772, 5189.766460509286, 4434.35701823237, 4570.680052396334, 4614.700044497131, 4653.976730116327, 4820.30105634681, 4979.327790748239, 5342.706151161685, 5618.073017952033, 5622.91565626516, 5661.264035675377, 3905.3556163233034, 3910.980445097785, 3928.40899435729, 3931.1351502669368, 3959.920801583952, 5011.373578302712, 5905.261842269716, 5925.140854576062, 5931.584789064767, 5941.435563621449, 3583.2018060855576, 3609.296187243462, 3873.4577159197734, 3875.418687196887, 3902.6682731967535, 3932.4297976793205, 3960.8019599019935, 3975.7018223633345, 3977.6643458630233, 3981.482407287034, 4268.381084742695, 4607.815687372535, 4630.53694630541, 4651.86044418668, 4658.906821863611, 4975.875603109951, 5343.4389389113585, 5683.9715801420725, 5792.189093526909, 5821.970890145522, 1138.425095326871, 1332.9000324975666, 1361.1832900259963, 1361.9863801362058, 1368.8911981295182, 783.8589053970226, 816.8938038055134, 831.6132998155765, 834.649447232164, 837.2632083766368, 4822.0, 4925.2119660854805, 4990.155611301523, 5117.74411279442, 5431.864203394946, 5043.0, 5391.894661594364, 5878.441548052928, 5906.607823831355, 5909.0, 4644.396228490275, 4889.853304400874, 4985.404670505403, 5109.3613298337705, 5422.457754224546, 2841.6447944007, 2991.311998240417, 3086.3518661080975, 3093.7370323522755, 3102.674219206951, 5586.636868603528, 5750.482456578844, 5775.325155704799, 5933.3473317934995, 6104.550928725256, 5129.717865517432, 5189.4032186299055, 5221.947780522146, 5334.253204551366, 5993.340732519419, 5565.749541270652, 5999.790112289904, 6037.577369584087, 6082.327359975953, 6106.969465152646, 5046.369203849519, 5533.723313834373, 5793.275840519935, 5846.327672317568, 5885.968111843401, 4867.0, 5751.986804618517, 5820.817193552418, 5825.854353641193, 5839.708014599338, 5100.719460429564, 6006.369331220334, 6076.422739839708, 6079.361667024898, 6106.297775755845, 3035.9070734535107, 3088.3977624363033, 3231.951520727144, 3367.6463971282665, 3402.1494626343415, 4067.877963661095, 4111.527174374985, 4404.757738324295, 4482.731036137842, 4740.502247263988, 4337.1976184405985, 4385.649148068083, 4766.782421865297, 4795.568398844121, 4912.631552633496, 4019.4372787810316, 4232.217039847638, 4391.297392417198, 4422.302395538654, 4770.045990801784, 4162.396452514429, 4349.78251087438, 4713.996551465682, 4743.0, 4787.473377928355, 4886.434621823571, 5359.892802143857, 5490.835274941758, 5535.114381698909, 5648.491635752637, 5098.796048158032, 5287.8678033047945, 5392.245085688085, 5526.485449120721, 5563.666180029211], "value": 3975.8372580683535, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.9492840572753, 732.5787672088551, 743.2196193996305, 783.6042798386814, 784.5606460382182, 14545.490907818228, 14944.178070206135, 15383.000104993182, 15401.383944642228, 15410.0, 13914.234717090556, 14054.929725351385, 14147.434102635882, 14175.007749457542, 14201.502947396843, 708.9432845372357, 732.3884556395416, 878.6046279174365, 880.3749337970049, 898.137787723786, 861.1775754154799, 862.1981557151846, 910.4673765846987, 915.4553040940663, 916.0061333453211, 957.2007373842849, 961.3366776923936, 962.7881865989506, 963.2294164668273, 964.6720115160844, 929.8279818233649, 953.8903026151943, 955.9904400956005, 958.6836344006531, 959.0313783079106, 679.1985457160548, 715.9212486626467, 719.0508528742063, 719.5215181904027, 721.412049179922, 14446.422143114263, 14476.638084047878, 14585.562433127023, 14600.926995365062, 15177.392904283815, 14028.789568156486, 14092.506762263272, 14277.0, 14318.57044288673, 14378.352974116086, 11383.829242561369, 11584.0, 11590.362530060927, 11650.359230242333, 11687.357195354252, 3732.309522738275, 3746.83139258734, 3846.0192650873846, 3895.14306852492, 3937.684985201177, 86265.13734862633, 88346.23307533814, 88612.11387886103, 88759.55620221922, 90026.0, 10722.517486713117, 10783.299085559414, 10827.512761925733, 10835.295705779099, 11269.830952535718, 21515.0, 21657.891710541662, 21789.782102178775, 21844.12623495074, 21850.781492185193, 7735.883961740578, 7805.921940780633, 7842.803929901798, 7936.047674279123, 7937.603119843985, 4187.832486700559, 4286.892827679333, 4311.8490852820005, 4345.500267469281, 4397.362382454527, 3432.8970130896114, 3454.274602333488, 3540.7698499597445, 3542.203004324058, 3602.945955810665, 652.5334385914094, 653.4576301669603, 662.0367365483211, 663.5056882622381, 673.579013116802, 636.4399328590903, 653.6404977262582, 661.983854782906, 684.9726010959506, 698.3470455124374, 8756.610869112254, 8929.292727807551, 9119.772005699779, 9189.678361257324, 9258.120478554527, 544.4446664402367, 583.4020129367433, 595.8361450601033, 629.3769168523221, 665.7170702451439, 4243.363495475642, 4393.912121757547, 4475.216837053503, 4511.210538155875, 4589.380433641482, 98249.0, 108236.0, 111195.0, 112457.0, 115186.0, 78333.0, 82870.0, 83282.0, 102093.48953255186, 103409.0, 45209.0, 52416.0, 62459.68770156211, 83201.58399208086, 84759.0, 7176.341166093432, 9795.470964848964, 9845.0, 9877.604895804086, 9964.701058968243, 50179.24731128963, 50369.74815125901, 53577.0, 55239.17141242804, 55283.17075243794, 71761.0, 72221.27778722356, 73414.26585734288, 77368.0, 79019.0, 12690.446674931034, 12882.162659427107, 12883.742325153631, 13010.089293749725, 13255.734885302432, 12172.57395991136, 14061.718765624835, 14269.143851368952, 14316.427342906167, 14812.407503700162, 10609.628662996758, 13254.403551839998, 13268.336583170996, 13358.666033349244, 13481.932590336986, 11497.022753066083, 13207.66980825487, 13288.601341959757, 13408.463661453823, 14894.553163405115, 9523.61905523799, 10175.778906531265, 10644.290982896524, 13059.934700326437, 13418.463261469431, 10572.788544229226, 11059.72350691239, 11215.327080375204, 11453.31280123162, 11463.770724585629, 9323.440593564408, 10189.439580823126, 10470.947645261725, 11456.828147577626, 11479.25384849982], "value": 7383.800766414291, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1601.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 119.0, 118.0, 137.0, 172.0, 152.0, 118.0, 121.0, 139.0, 173.0], "value": 136.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 100.0, 181.0, 142.0, 147.0, 116.0, 113.0, 143.0, 115.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 199.0, 206.0, 239.0, 197.0, 201.0, 203.0, 236.0, 196.0, 193.0], "value": 206.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 59.0, 60.0, 80.0, 61.0, 72.0, 82.0, 58.0, 87.0, 84.0], "value": 71.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 85.0, 73.0, 70.0, 70.0, 91.0, 100.0, 79.0, 122.0], "value": 84.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 126.0, 90.0, 88.0, 91.0, 86.0, 89.0, 87.0, 89.0, 86.0], "value": 95.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 101.0, 100.0, 103.0, 100.0, 100.0, 100.0, 137.0, 120.0], "value": 106.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 138.0, 137.0, 90.0, 86.0, 88.0, 93.0, 142.0, 77.0, 135.0], "value": 107.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 48.0, 51.0, 78.0, 82.0, 90.0, 89.0, 88.0, 85.0], "value": 70.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 71.0, 78.0, 74.0, 70.0, 68.0, 68.0, 86.0, 74.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 84.0, 87.0, 81.0, 92.0, 112.0, 90.0, 90.0, 94.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 144.0, 148.0, 152.0, 163.0, 167.0, 143.0, 191.0, 150.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 175.0, 174.0, 174.0, 174.0, 176.0, 177.0, 218.0, 244.0, 242.0], "value": 193.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 69.0, 71.0, 73.0, 71.0, 70.0, 67.0, 77.0, 95.0], "value": 73.3, "unit": "score"}]}]} 14:12:02 INFO - Return code: 0 14:12:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:12:02 ERROR - # TBPL SUCCESS # 14:12:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:12:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:12:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:12:02 INFO - 2016-10-26 14:12:02.383 screenresolution[1674:11546] starting screenresolution argv=screenresolution get 14:12:02 INFO - 2016-10-26 14:12:02.385 screenresolution[1674:11546] Display 0: 1600x1200x32@60 14:12:02 INFO - 2016-10-26 14:12:02.392 screenresolution[1675:11549] starting screenresolution argv=screenresolution list 14:12:02 INFO - Available Modes on Display 0 14:12:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:12:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:12:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:12:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:12:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:12:02 INFO - Intel Iris: 14:12:02 INFO - Chipset Model: Intel Iris 14:12:02 INFO - Type: GPU 14:12:02 INFO - Bus: Built-In 14:12:02 INFO - VRAM (Dynamic, Max): 1536 MB 14:12:02 INFO - Vendor: Intel (0x8086) 14:12:02 INFO - Device ID: 0x0a2e 14:12:02 INFO - Revision ID: 0x0009 14:12:02 INFO - Displays: 14:12:02 INFO - Display: 14:12:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:12:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:12:02 INFO - Display Serial Number: 1600x1200 60 14:12:02 INFO - Main Display: Yes 14:12:02 INFO - Mirror: Off 14:12:02 INFO - Online: Yes 14:12:02 INFO - Rotation: Supported 14:12:02 INFO - Return code: 0 14:12:02 INFO - Running post-action listener: _resource_record_post_action 14:12:02 INFO - [mozharness: 2016-10-26 21:12:02.633705Z] Finished run-tests step (success) 14:12:02 INFO - Running post-run listener: _resource_record_post_run 14:12:02 INFO - Total resource usage - Wall time: 1212s; CPU: 55.0%; Read bytes: 45700608; Write bytes: 722987520; Read time: 541; Write time: 2303 14:12:02 INFO - TinderboxPrint: CPU usage
54.7% 14:12:02 INFO - TinderboxPrint: I/O read bytes / time
45,700,608 / 541 14:12:02 INFO - TinderboxPrint: I/O write bytes / time
722,987,520 / 2,303 14:12:02 INFO - TinderboxPrint: CPU idle
2,195.1 (45.3%) 14:12:02 INFO - TinderboxPrint: CPU system
986.5 (20.3%) 14:12:02 INFO - TinderboxPrint: CPU user
1,668.1 (34.4%) 14:12:02 INFO - TinderboxPrint: Swap in / out
442,114,048 / 0 14:12:02 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 395381248; Write bytes: 390744064; Read time: 29312; Write time: 764 14:12:02 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 44758528; Write bytes: 312660480; Read time: 526; Write time: 1489 14:12:03 INFO - Running post-run listener: _upload_blobber_files 14:12:03 INFO - Blob upload gear active. 14:12:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:12:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:12:03 INFO - (blobuploader) - INFO - Open directory for files ... 14:12:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:12:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:12:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:04 INFO - (blobuploader) - INFO - Done attempting. 14:12:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:12:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:12:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:05 INFO - (blobuploader) - INFO - Done attempting. 14:12:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:12:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:12:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:08 INFO - (blobuploader) - INFO - Done attempting. 14:12:08 INFO - (blobuploader) - INFO - Iteration through files over. 14:12:08 INFO - Return code: 0 14:12:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:12:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:12:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32655229105224ea0e5589ebcef13d35435010d145d13db02eca0244c9314a366081863eb1a4fa90ba0c02b02214bd3cbc060505bca95bd32cf8733262ee9f8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ca8e0890a887de193a1484b35c7897786bb0517adf28a758cb8f088ced43980bd5a29c56695f7f06795cf0bd1fe54b085c48a685efe1d5ae506c06760200ee7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8981a4eb558a505199ec346e0ae530d0dddbe317ae79477a63d51561c4384a1c6de84910c570095926cc08b3647c8a2ec941f9d404bdef2e8a5a1d7811fb0850"} 14:12:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:12:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:12:08 INFO - Contents: 14:12:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32655229105224ea0e5589ebcef13d35435010d145d13db02eca0244c9314a366081863eb1a4fa90ba0c02b02214bd3cbc060505bca95bd32cf8733262ee9f8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ca8e0890a887de193a1484b35c7897786bb0517adf28a758cb8f088ced43980bd5a29c56695f7f06795cf0bd1fe54b085c48a685efe1d5ae506c06760200ee7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8981a4eb558a505199ec346e0ae530d0dddbe317ae79477a63d51561c4384a1c6de84910c570095926cc08b3647c8a2ec941f9d404bdef2e8a5a1d7811fb0850"} 14:12:08 INFO - Running post-run listener: copy_logs_to_upload_dir 14:12:08 INFO - Copying logs to upload dir... 14:12:08 INFO - mkdir: /builds/slave/test/build/upload/logs 14:12:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.246447 ========= master_lag: 2.99 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-26 14:12:11.481245) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:12:11.488124) ========= 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.NkCX5bdFyJ/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.8UlWh8poki/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32655229105224ea0e5589ebcef13d35435010d145d13db02eca0244c9314a366081863eb1a4fa90ba0c02b02214bd3cbc060505bca95bd32cf8733262ee9f8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ca8e0890a887de193a1484b35c7897786bb0517adf28a758cb8f088ced43980bd5a29c56695f7f06795cf0bd1fe54b085c48a685efe1d5ae506c06760200ee7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8981a4eb558a505199ec346e0ae530d0dddbe317ae79477a63d51561c4384a1c6de84910c570095926cc08b3647c8a2ec941f9d404bdef2e8a5a1d7811fb0850"} build_url:https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011819 build_url: 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32655229105224ea0e5589ebcef13d35435010d145d13db02eca0244c9314a366081863eb1a4fa90ba0c02b02214bd3cbc060505bca95bd32cf8733262ee9f8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ca8e0890a887de193a1484b35c7897786bb0517adf28a758cb8f088ced43980bd5a29c56695f7f06795cf0bd1fe54b085c48a685efe1d5ae506c06760200ee7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8981a4eb558a505199ec346e0ae530d0dddbe317ae79477a63d51561c4384a1c6de84910c570095926cc08b3647c8a2ec941f9d404bdef2e8a5a1d7811fb0850"}' ========= master_lag: 0.20 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:12:11.699758) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-10-26 14:12:11.700143) ========= 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.NkCX5bdFyJ/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.8UlWh8poki/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.004568 ========= master_lag: 3.39 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-10-26 14:12:15.095212) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:12:15.095535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:12:15.186457) ========= ========= Total master_lag: 6.64 =========