builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0379 starttime: 1484756086.61 results: success (0) buildid: 20170118065326 builduid: 2eb940a1d5614c7cbdcbf9bb2aab6df6 revision: 8a2f1d1241fa944e682e20650584921e1ca90e29 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 08:14:46.609518) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 08:14:46.609959) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 08:14:46.610263) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 08:14:46.635217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:14:46.635633) ========= 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.4UsUtRNOWB/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.obsuLi75vm/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-18 08:14:46-- 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% 39.9M=0s 2017-01-18 08:14:46 (39.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114935 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:14:46.774175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:14:46.774495) ========= 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.4UsUtRNOWB/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.obsuLi75vm/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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.019684 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:14:46.823503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-01-18 08:14:46.823894) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8a2f1d1241fa944e682e20650584921e1ca90e29 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8a2f1d1241fa944e682e20650584921e1ca90e29 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4UsUtRNOWB/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.obsuLi75vm/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-18 08:14:46,912 truncating revision to first 12 chars 2017-01-18 08:14:46,912 Setting DEBUG logging. 2017-01-18 08:14:46,912 attempt 1/10 2017-01-18 08:14:46,912 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8a2f1d1241fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 08:14:48,837 unpacking tar archive at: mozilla-aurora-8a2f1d1241fa/testing/mozharness/ program finished with exit code 0 elapsedTime=2.166026 ========= master_lag: 1.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-01-18 08:14:50.067232) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 08:14:50.067652) ========= script_repo_revision: 8a2f1d1241fa944e682e20650584921e1ca90e29 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 08:14:50.068074) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 08:14:50.068353) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 08:14:50.091367) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-01-18 08:14:50.091768) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4UsUtRNOWB/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.obsuLi75vm/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 08:14:50 INFO - MultiFileLogger online at 20170118 08:14:50 in /builds/slave/test 08:14:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:14:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:50 INFO - {'append_to_log': False, 08:14:50 INFO - 'base_work_dir': '/builds/slave/test', 08:14:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:14:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:50 INFO - 'branch': 'Mozilla-Aurora', 08:14:50 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:50 INFO - 'config_files': ('talos/mac_config.py',), 08:14:50 INFO - 'default_actions': ('clobber', 08:14:50 INFO - 'read-buildbot-config', 08:14:50 INFO - 'download-and-extract', 08:14:50 INFO - 'populate-webroot', 08:14:50 INFO - 'create-virtualenv', 08:14:50 INFO - 'install', 08:14:50 INFO - 'run-tests'), 08:14:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:50 INFO - 'download_minidump_stackwalk': True, 08:14:50 INFO - 'download_symbols': 'ondemand', 08:14:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:50 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:50 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:50 INFO - 'installer_path': 'installer.exe', 08:14:50 INFO - 'log_level': 'info', 08:14:50 INFO - 'log_name': 'talos', 08:14:50 INFO - 'log_to_console': True, 08:14:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:14:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:14:50 INFO - 'opt_config_files': (), 08:14:50 INFO - 'pip_index': False, 08:14:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:14:50 INFO - 'cmd': ('bash', 08:14:50 INFO - '-c', 08:14:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:14:50 INFO - 'enabled': True, 08:14:50 INFO - 'halt_on_failure': False, 08:14:50 INFO - 'name': 'check_screen_resolution'},), 08:14:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:14:50 INFO - 'cmd': ('bash', 08:14:50 INFO - '-c', 08:14:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:14:50 INFO - 'enabled': True, 08:14:50 INFO - 'halt_on_failure': False, 08:14:50 INFO - 'name': 'check_screen_resolution'},), 08:14:50 INFO - 'run_cmd_checks_enabled': True, 08:14:50 INFO - 'sps_profile': False, 08:14:50 INFO - 'sps_profile_interval': 0, 08:14:50 INFO - 'suite': 'dromaeojs-e10s', 08:14:50 INFO - 'system_bits': '32', 08:14:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:50 INFO - 'title': 't-yosemite-r7-0379', 08:14:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:50 INFO - 'use_talos_json': True, 08:14:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:50 INFO - 'work_dir': 'build'} 08:14:50 INFO - [mozharness: 2017-01-18 16:14:50.295008Z] Running clobber step. 08:14:50 INFO - Running pre-action listener: _resource_record_pre_action 08:14:50 INFO - Running main action method: clobber 08:14:50 INFO - rmtree: /builds/slave/test/build 08:14:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:51 INFO - Running post-action listener: _resource_record_post_action 08:14:51 INFO - [mozharness: 2017-01-18 16:14:51.766547Z] Finished clobber step (success) 08:14:51 INFO - [mozharness: 2017-01-18 16:14:51.766706Z] Running read-buildbot-config step. 08:14:51 INFO - Running pre-action listener: _resource_record_pre_action 08:14:51 INFO - Running main action method: read_buildbot_config 08:14:51 INFO - Using buildbot properties: 08:14:51 INFO - { 08:14:51 INFO - "project": "", 08:14:51 INFO - "product": "firefox", 08:14:51 INFO - "script_repo_revision": "production", 08:14:51 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:14:51 INFO - "repository": "", 08:14:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:14:51 INFO - "buildid": "20170118065326", 08:14:51 INFO - "pgo_build": "False", 08:14:51 INFO - "basedir": "/builds/slave/test", 08:14:51 INFO - "buildnumber": 79, 08:14:51 INFO - "slavename": "t-yosemite-r7-0379", 08:14:51 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 08:14:51 INFO - "platform": "yosemite_r7", 08:14:51 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:14:51 INFO - "branch": "mozilla-aurora", 08:14:51 INFO - "repo_path": "releases/mozilla-aurora", 08:14:51 INFO - "revision": "8a2f1d1241fa944e682e20650584921e1ca90e29", 08:14:51 INFO - "stage_platform": "macosx64", 08:14:51 INFO - "builduid": "2eb940a1d5614c7cbdcbf9bb2aab6df6", 08:14:51 INFO - "slavebuilddir": "test" 08:14:51 INFO - } 08:14:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:14:51 INFO - Running post-action listener: _resource_record_post_action 08:14:51 INFO - [mozharness: 2017-01-18 16:14:51.770081Z] Finished read-buildbot-config step (success) 08:14:51 INFO - [mozharness: 2017-01-18 16:14:51.770188Z] Running download-and-extract step. 08:14:51 INFO - Running pre-action listener: _resource_record_pre_action 08:14:51 INFO - Running main action method: download_and_extract 08:14:51 INFO - mkdir: /builds/slave/test/build/tests 08:14:51 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')]} 08:14:51 INFO - trying https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:14:51 INFO - Downloading https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:14:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 08:14:52 INFO - Downloaded 1199 bytes. 08:14:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:14:52 INFO - Using the following test package requirements: 08:14:52 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:14:52 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:14:52 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:14:52 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:14:52 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:14:52 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:14:52 INFO - u'jsshell-mac.zip'], 08:14:52 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:14:52 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:14:52 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:14:52 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:14:52 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:14:52 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:14:52 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:14:52 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:14:52 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:14:52 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:14:52 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:14:52 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:14:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:14:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:14:52 INFO - Fetch https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:14:52 INFO - Http code: 200 08:14:52 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 08:14:52 INFO - x-amz-cf-id: I_dh7euhBXJOA-rk6LM8f2oDWC8tbN9Nr5NShNIAuk0zhOVXBlD3Ug== 08:14:52 INFO - x-amz-version-id: mpzz.r4Vy.V1x2HFIqysx8cZGQ4gIGmX 08:14:53 INFO - Expected file size: 16276068 08:14:53 INFO - Obtained file size: 16276068 08:15:00 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:15:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:15:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:15:00 INFO - Fetch https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:15:00 INFO - Http code: 200 08:15:00 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 08:15:00 INFO - x-amz-cf-id: 7maIoYxBYTYMT4APr2KThxUP2_WKkGc7brl8mVaR7-kqawhxyVYLLA== 08:15:00 INFO - x-amz-version-id: mpzz.r4Vy.V1x2HFIqysx8cZGQ4gIGmX 08:15:01 INFO - Expected file size: 16276068 08:15:01 INFO - Obtained file size: 16276068 08:15:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:15:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:15:07 INFO - Fetch https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:15:07 INFO - Http code: 200 08:15:07 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 08:15:07 INFO - x-amz-cf-id: WFqh7sp9kAYmnBnXd5qGR3L2ao87LjVpQFz7nu_Dr2jDi-ps1hWsKg== 08:15:07 INFO - x-amz-version-id: gz8D66RNtREVeMq10tw1jZSozbRZl2kQ 08:15:08 INFO - Expected file size: 14409038 08:15:08 INFO - Obtained file size: 14409038 08:15:08 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')]} 08:15:08 INFO - trying https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:15:08 INFO - Downloading https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:15:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 08:15:11 INFO - Downloaded 110006748 bytes. 08:15:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:15:11 INFO - mkdir: /builds/slave/test/properties 08:15:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:15:11 INFO - Writing to file /builds/slave/test/properties/build_url 08:15:11 INFO - Contents: 08:15:11 INFO - build_url:https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:15:12 INFO - Running post-action listener: _resource_record_post_action 08:15:12 INFO - Running post-action listener: set_extra_try_arguments 08:15:12 INFO - [mozharness: 2017-01-18 16:15:12.455700Z] Finished download-and-extract step (success) 08:15:12 INFO - [mozharness: 2017-01-18 16:15:12.455854Z] Running populate-webroot step. 08:15:12 INFO - Running pre-action listener: _resource_record_pre_action 08:15:12 INFO - Running main action method: populate_webroot 08:15:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:15:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:15:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:15:12 INFO - '--tppagecycles', 08:15:12 INFO - '7'], 08:15:12 INFO - 'tests': ['tsvgm']}}, 08:15:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:15:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:15:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:15:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:15:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:15:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:15:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:12 INFO - 'talos_options': ['--disable-e10s'], 08:15:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:12 INFO - 'talos_options': ['--disable-e10s'], 08:15:12 INFO - 'tests': ['damp', 'tps']}, 08:15:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:12 INFO - 'tests': ['damp', 'tps']}, 08:15:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:15:12 INFO - 'tests': ['dromaeo_dom']}, 08:15:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:15:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:15:12 INFO - 'tests': ['basic_compositor_video']}, 08:15:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:15:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:15:12 INFO - 'tests': ['a11yr', 08:15:12 INFO - 'ts_paint', 08:15:12 INFO - 'tpaint', 08:15:12 INFO - 'sessionrestore', 08:15:12 INFO - 'sessionrestore_no_auto_restore', 08:15:12 INFO - 'tabpaint']}, 08:15:12 INFO - 'other-e10s': {'tests': ['a11yr', 08:15:12 INFO - 'ts_paint', 08:15:12 INFO - 'tpaint', 08:15:12 INFO - 'sessionrestore', 08:15:12 INFO - 'sessionrestore_no_auto_restore', 08:15:12 INFO - 'tabpaint']}, 08:15:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:15:12 INFO - 'ts_paint', 08:15:12 INFO - 'tpaint', 08:15:12 INFO - 'sessionrestore', 08:15:12 INFO - 'sessionrestore_no_auto_restore', 08:15:12 INFO - 'tabpaint']}, 08:15:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:15:12 INFO - 'ts_paint', 08:15:12 INFO - 'tpaint', 08:15:12 INFO - 'sessionrestore', 08:15:12 INFO - 'sessionrestore_no_auto_restore', 08:15:12 INFO - 'tabpaint']}, 08:15:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:15:12 INFO - 'tests': ['a11yr', 08:15:12 INFO - 'ts_paint', 08:15:12 INFO - 'tpaint', 08:15:12 INFO - 'sessionrestore', 08:15:12 INFO - 'sessionrestore_no_auto_restore', 08:15:12 INFO - 'tabpaint']}, 08:15:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:15:12 INFO - 'tests': ['a11yr', 08:15:12 INFO - 'ts_paint', 08:15:12 INFO - 'tpaint', 08:15:12 INFO - 'sessionrestore', 08:15:12 INFO - 'sessionrestore_no_auto_restore', 08:15:12 INFO - 'tabpaint']}, 08:15:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:15:12 INFO - 'tests': ['tsvgx', 08:15:12 INFO - 'tsvgr_opacity', 08:15:12 INFO - 'tart', 08:15:12 INFO - 'tscrollx', 08:15:12 INFO - 'cart']}, 08:15:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:15:12 INFO - 'tsvgr_opacity', 08:15:12 INFO - 'tart', 08:15:12 INFO - 'tscrollx', 08:15:12 INFO - 'cart']}, 08:15:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:12 INFO - 'talos_options': ['--disable-e10s'], 08:15:12 INFO - 'tests': ['tp5o']}, 08:15:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:12 INFO - 'tests': ['tp5o']}, 08:15:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:12 INFO - 'talos_options': ['--disable-e10s', 08:15:12 INFO - '--xperf_path', 08:15:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:12 INFO - 'tests': ['tp5n']}, 08:15:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:12 INFO - 'talos_options': ['--xperf_path', 08:15:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:12 INFO - 'tests': ['tp5n']}}, 08:15:12 INFO - 'talos.zip': {'path': '', 08:15:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:15:12 INFO - Running post-action listener: _resource_record_post_action 08:15:12 INFO - [mozharness: 2017-01-18 16:15:12.474607Z] Finished populate-webroot step (success) 08:15:12 INFO - [mozharness: 2017-01-18 16:15:12.474737Z] Running create-virtualenv step. 08:15:12 INFO - Running pre-action listener: _resource_record_pre_action 08:15:12 INFO - Running main action method: create_virtualenv 08:15:12 INFO - Creating virtualenv /builds/slave/test/build/venv 08:15:12 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 08:15:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:15:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:15:12 INFO - Using real prefix '/tools/python27' 08:15:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:15:13 INFO - Installing distribute.............................................................................................................................................................................................done. 08:15:16 INFO - Installing pip.................done. 08:15:16 INFO - Return code: 0 08:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:15:16 INFO - Reading from file tmpfile_stdout 08:15:16 INFO - Output received: 08:15:16 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) 08:15:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:15:16 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')]} 08:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:16 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')]} 08:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:16 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 0x1043a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104317570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693c83940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041b5d30>, '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 0x10401bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041adb20>, '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.4UsUtRNOWB/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.obsuLi75vm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 08:15:16 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 08:15:16 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 08:15:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UsUtRNOWB/Render', 08:15:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:16 INFO - 'HOME': '/Users/cltbld', 08:15:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:16 INFO - 'LOGNAME': 'cltbld', 08:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:16 INFO - 'MOZ_NO_REMOTE': '1', 08:15:16 INFO - 'NO_EM_RESTART': '1', 08:15:16 INFO - 'PAGER': '/bin/cat', 08:15:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:16 INFO - 'PWD': '/builds/slave/test', 08:15:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:16 INFO - 'SHELL': '/bin/bash', 08:15:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obsuLi75vm/Listeners', 08:15:16 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:15:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:16 INFO - 'USER': 'cltbld', 08:15:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:16 INFO - 'XPC_FLAGS': '0x0', 08:15:16 INFO - 'XPC_SERVICE_NAME': '0', 08:15:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:16 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 08:15:16 INFO - Cleaning up... 08:15:16 INFO - Return code: 0 08:15:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:15:16 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')]} 08:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:16 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')]} 08:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:16 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 0x1043a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104317570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693c83940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041b5d30>, '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 0x10401bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041adb20>, '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.4UsUtRNOWB/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.obsuLi75vm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 08:15:16 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 08:15:16 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 08:15:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UsUtRNOWB/Render', 08:15:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:16 INFO - 'HOME': '/Users/cltbld', 08:15:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:16 INFO - 'LOGNAME': 'cltbld', 08:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:16 INFO - 'MOZ_NO_REMOTE': '1', 08:15:16 INFO - 'NO_EM_RESTART': '1', 08:15:16 INFO - 'PAGER': '/bin/cat', 08:15:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:16 INFO - 'PWD': '/builds/slave/test', 08:15:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:16 INFO - 'SHELL': '/bin/bash', 08:15:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obsuLi75vm/Listeners', 08:15:16 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:15:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:16 INFO - 'USER': 'cltbld', 08:15:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:16 INFO - 'XPC_FLAGS': '0x0', 08:15:16 INFO - 'XPC_SERVICE_NAME': '0', 08:15:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:16 INFO - Downloading/unpacking psutil>=3.1.1 08:15:16 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 08:15:16 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 08:15:16 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 08:15:16 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 08:15:16 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 08:15:16 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 08:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:15:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:20 INFO - Installing collected packages: psutil 08:15:20 INFO - Running setup.py install for psutil 08:15:20 INFO - building 'psutil._psutil_osx' extension 08:15:20 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 08:15:21 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 08:15:21 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 08:15:21 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 08:15:21 INFO - building 'psutil._psutil_posix' extension 08:15:21 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 08:15:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:15:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:15:21 INFO - ^ 08:15:21 INFO - 1 warning generated. 08:15:21 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 08:15:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:21 INFO - Successfully installed psutil 08:15:21 INFO - Cleaning up... 08:15:21 INFO - Return code: 0 08:15:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104317570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693c83940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041b5d30>, '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 0x10401bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041adb20>, '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.4UsUtRNOWB/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.obsuLi75vm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 08:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:15:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UsUtRNOWB/Render', 08:15:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:21 INFO - 'HOME': '/Users/cltbld', 08:15:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:21 INFO - 'LOGNAME': 'cltbld', 08:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:21 INFO - 'MOZ_NO_REMOTE': '1', 08:15:21 INFO - 'NO_EM_RESTART': '1', 08:15:21 INFO - 'PAGER': '/bin/cat', 08:15:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:21 INFO - 'PWD': '/builds/slave/test', 08:15:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:21 INFO - 'SHELL': '/bin/bash', 08:15:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obsuLi75vm/Listeners', 08:15:21 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:15:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:21 INFO - 'USER': 'cltbld', 08:15:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:21 INFO - 'XPC_FLAGS': '0x0', 08:15:21 INFO - 'XPC_SERVICE_NAME': '0', 08:15:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:15:21 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 08:15:21 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 08:15:21 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 08:15:21 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 08:15:21 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 08:15:21 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 08:15:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:15:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:15:24 INFO - Installing collected packages: mozsystemmonitor 08:15:24 INFO - Running setup.py install for mozsystemmonitor 08:15:24 INFO - Successfully installed mozsystemmonitor 08:15:24 INFO - Cleaning up... 08:15:24 INFO - Return code: 0 08:15:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:24 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 0x1043a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104317570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693c83940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041b5d30>, '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 0x10401bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041adb20>, '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.4UsUtRNOWB/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.obsuLi75vm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 08:15:24 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 08:15:24 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 08:15:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UsUtRNOWB/Render', 08:15:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:24 INFO - 'HOME': '/Users/cltbld', 08:15:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:24 INFO - 'LOGNAME': 'cltbld', 08:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:24 INFO - 'MOZ_NO_REMOTE': '1', 08:15:24 INFO - 'NO_EM_RESTART': '1', 08:15:24 INFO - 'PAGER': '/bin/cat', 08:15:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:24 INFO - 'PWD': '/builds/slave/test', 08:15:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:24 INFO - 'SHELL': '/bin/bash', 08:15:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obsuLi75vm/Listeners', 08:15:24 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:15:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:24 INFO - 'USER': 'cltbld', 08:15:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:24 INFO - 'XPC_FLAGS': '0x0', 08:15:24 INFO - 'XPC_SERVICE_NAME': '0', 08:15:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:24 INFO - Downloading/unpacking jsonschema==2.5.1 08:15:24 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 08:15:24 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 08:15:24 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 08:15:24 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 08:15:24 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 08:15:24 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 08:15:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:15:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:27 INFO - Downloading functools32-3.2.3-2.tar.gz 08:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:15:28 INFO - warning: no files found matching '*.txt' 08:15:28 INFO - no previously-included directories found matching 'build' 08:15:28 INFO - no previously-included directories found matching 'dist' 08:15:28 INFO - no previously-included directories found matching '.git*' 08:15:28 INFO - Installing collected packages: jsonschema, functools32 08:15:28 INFO - Running setup.py install for functools32 08:15:28 INFO - warning: no files found matching '*.txt' 08:15:28 INFO - no previously-included directories found matching 'build' 08:15:28 INFO - no previously-included directories found matching 'dist' 08:15:28 INFO - no previously-included directories found matching '.git*' 08:15:28 INFO - Successfully installed jsonschema functools32 08:15:28 INFO - Cleaning up... 08:15:28 INFO - Return code: 0 08:15:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1043a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104317570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693c83940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041b5d30>, '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 0x10401bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041adb20>, '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.4UsUtRNOWB/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.obsuLi75vm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 08:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:15:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UsUtRNOWB/Render', 08:15:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:28 INFO - 'HOME': '/Users/cltbld', 08:15:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:28 INFO - 'LOGNAME': 'cltbld', 08:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:28 INFO - 'MOZ_NO_REMOTE': '1', 08:15:28 INFO - 'NO_EM_RESTART': '1', 08:15:28 INFO - 'PAGER': '/bin/cat', 08:15:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:28 INFO - 'PWD': '/builds/slave/test', 08:15:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:28 INFO - 'SHELL': '/bin/bash', 08:15:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obsuLi75vm/Listeners', 08:15:28 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:15:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:28 INFO - 'USER': 'cltbld', 08:15:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:28 INFO - 'XPC_FLAGS': '0x0', 08:15:28 INFO - 'XPC_SERVICE_NAME': '0', 08:15:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:15:28 INFO - Cleaning up... 08:15:28 INFO - Return code: 0 08:15:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1043a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104317570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693c83940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041b5d30>, '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 0x10401bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041adb20>, '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.4UsUtRNOWB/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.obsuLi75vm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 08:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:15:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UsUtRNOWB/Render', 08:15:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:28 INFO - 'HOME': '/Users/cltbld', 08:15:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:28 INFO - 'LOGNAME': 'cltbld', 08:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:28 INFO - 'MOZ_NO_REMOTE': '1', 08:15:28 INFO - 'NO_EM_RESTART': '1', 08:15:28 INFO - 'PAGER': '/bin/cat', 08:15:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:28 INFO - 'PWD': '/builds/slave/test', 08:15:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:28 INFO - 'SHELL': '/bin/bash', 08:15:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obsuLi75vm/Listeners', 08:15:28 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:15:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:28 INFO - 'USER': 'cltbld', 08:15:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:28 INFO - 'XPC_FLAGS': '0x0', 08:15:28 INFO - 'XPC_SERVICE_NAME': '0', 08:15:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:28 INFO - Downloading/unpacking blobuploader==1.2.4 08:15: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 08:15: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 08:15: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 08:15: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 08:15: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 08:15: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 08:15:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:15:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:15: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 08:15: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 08:15: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 08:15: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 08:15: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 08:15: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 08:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:15:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:32 INFO - Downloading docopt-0.6.1.tar.gz 08:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:15:32 INFO - Installing collected packages: blobuploader, requests, docopt 08:15:32 INFO - Running setup.py install for blobuploader 08:15:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:15:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:15:33 INFO - Running setup.py install for requests 08:15:33 INFO - Running setup.py install for docopt 08:15:33 INFO - Successfully installed blobuploader requests docopt 08:15:33 INFO - Cleaning up... 08:15:33 INFO - Return code: 0 08:15:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:33 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 0x1043a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104317570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693c83940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041b5d30>, '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 0x10401bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041adb20>, '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.4UsUtRNOWB/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.obsuLi75vm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 08:15:33 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 08:15:33 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 08:15:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UsUtRNOWB/Render', 08:15:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:33 INFO - 'HOME': '/Users/cltbld', 08:15:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:33 INFO - 'LOGNAME': 'cltbld', 08:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:33 INFO - 'MOZ_NO_REMOTE': '1', 08:15:33 INFO - 'NO_EM_RESTART': '1', 08:15:33 INFO - 'PAGER': '/bin/cat', 08:15:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:33 INFO - 'PWD': '/builds/slave/test', 08:15:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:33 INFO - 'SHELL': '/bin/bash', 08:15:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obsuLi75vm/Listeners', 08:15:33 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:15:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:33 INFO - 'USER': 'cltbld', 08:15:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:33 INFO - 'XPC_FLAGS': '0x0', 08:15:33 INFO - 'XPC_SERVICE_NAME': '0', 08:15:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-rFSDPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-E2FXqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-0oWmhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-H7l2Z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-MAqStL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-nIJjW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-RWniqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-DKMp3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-hwY8tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-32GpED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-9gc0Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-jlBM9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-a_90uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-mt2Kn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-4HrI5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-LlEuB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-sSE9C2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:15:35 INFO - Running setup.py install for manifestparser 08:15:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:15:35 INFO - Running setup.py install for mozcrash 08:15:36 INFO - Running setup.py install for mozdebug 08:15:36 INFO - Running setup.py install for mozdevice 08:15:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:15:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:15:36 INFO - Running setup.py install for mozfile 08:15:36 INFO - Running setup.py install for mozhttpd 08:15:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:15:36 INFO - Running setup.py install for mozinfo 08:15:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:15:36 INFO - Running setup.py install for mozInstall 08:15:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:15:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:15:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:15:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:15:36 INFO - Running setup.py install for mozleak 08:15:37 INFO - Running setup.py install for mozlog 08:15:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:15:37 INFO - Running setup.py install for moznetwork 08:15:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:15:37 INFO - Running setup.py install for mozprocess 08:15:37 INFO - Running setup.py install for mozprofile 08:15:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:15:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:15:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:15:37 INFO - Running setup.py install for mozrunner 08:15:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:15:37 INFO - Running setup.py install for mozscreenshot 08:15:38 INFO - Running setup.py install for moztest 08:15:38 INFO - Running setup.py install for mozversion 08:15:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:15:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:15:38 INFO - Cleaning up... 08:15:38 INFO - Return code: 0 08:15:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:38 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 0x1043a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104317570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693c83940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041b5d30>, '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 0x10401bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041adb20>, '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.4UsUtRNOWB/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.obsuLi75vm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 08:15:38 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 08:15:38 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 08:15:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UsUtRNOWB/Render', 08:15:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:38 INFO - 'HOME': '/Users/cltbld', 08:15:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:38 INFO - 'LOGNAME': 'cltbld', 08:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:38 INFO - 'MOZ_NO_REMOTE': '1', 08:15:38 INFO - 'NO_EM_RESTART': '1', 08:15:38 INFO - 'PAGER': '/bin/cat', 08:15:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:38 INFO - 'PWD': '/builds/slave/test', 08:15:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:38 INFO - 'SHELL': '/bin/bash', 08:15:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obsuLi75vm/Listeners', 08:15:38 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:15:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:38 INFO - 'USER': 'cltbld', 08:15:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:38 INFO - 'XPC_FLAGS': '0x0', 08:15:38 INFO - 'XPC_SERVICE_NAME': '0', 08:15:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:38 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-Mcf4HJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:38 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)) 08:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:38 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-V40vTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:38 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-qumqAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:39 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)) 08:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-2hGfPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:39 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)) 08:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-VKSV1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:39 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)) 08:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-TOWHca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:39 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)) 08:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-KWwLKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:39 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)) 08:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-sfkjJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:39 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)) 08:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-jDwqpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:39 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)) 08:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-UCu3I9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:39 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)) 08:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-uigicu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:39 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)) 08:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-QbZGBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:39 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)) 08:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-aBduxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:40 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)) 08:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-Tk6l7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-LlOWTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:40 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)) 08:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-bcLQ5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-6Hw1ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:40 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)) 08:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:15:40 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)) 08:15:40 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)) 08:15:40 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)) 08:15:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:15:40 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 08:15:40 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 08:15:40 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 08:15:40 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 08:15:40 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 08:15:40 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 08:15:43 INFO - Downloading blessings-1.6.tar.gz 08:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:15:43 INFO - Installing collected packages: blessings 08:15:43 INFO - Running setup.py install for blessings 08:15:43 INFO - Successfully installed blessings 08:15:43 INFO - Cleaning up... 08:15:43 INFO - Return code: 0 08:15:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:15:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:44 INFO - Reading from file tmpfile_stdout 08:15:44 INFO - Current package versions: 08:15:44 INFO - blessings == 1.6 08:15:44 INFO - blobuploader == 1.2.4 08:15:44 INFO - docopt == 0.6.1 08:15:44 INFO - functools32 == 3.2.3-2 08:15:44 INFO - jsonschema == 2.5.1 08:15:44 INFO - manifestparser == 1.1 08:15:44 INFO - mozInstall == 1.12 08:15:44 INFO - mozcrash == 1.0 08:15:44 INFO - mozdebug == 0.1 08:15:44 INFO - mozdevice == 0.48 08:15:44 INFO - mozfile == 1.2 08:15:44 INFO - mozhttpd == 0.7 08:15:44 INFO - mozinfo == 0.9 08:15:44 INFO - mozleak == 0.1 08:15:44 INFO - mozlog == 3.4 08:15:44 INFO - moznetwork == 0.27 08:15:44 INFO - mozprocess == 0.23 08:15:44 INFO - mozprofile == 0.28 08:15:44 INFO - mozrunner == 6.13 08:15:44 INFO - mozscreenshot == 0.1 08:15:44 INFO - mozsystemmonitor == 0.3 08:15:44 INFO - moztest == 0.8 08:15:44 INFO - mozversion == 1.4 08:15:44 INFO - psutil == 3.1.1 08:15:44 INFO - requests == 1.2.3 08:15:44 INFO - wsgiref == 0.1.2 08:15:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15: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')]} 08:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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')]} 08:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:44 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 0x1043a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104317570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693c83940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041b5d30>, '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 0x10401bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041adb20>, '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.4UsUtRNOWB/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.obsuLi75vm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 08:15:44 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 08:15:44 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 08:15:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UsUtRNOWB/Render', 08:15:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:44 INFO - 'HOME': '/Users/cltbld', 08:15:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:44 INFO - 'LOGNAME': 'cltbld', 08:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:44 INFO - 'MOZ_NO_REMOTE': '1', 08:15:44 INFO - 'NO_EM_RESTART': '1', 08:15:44 INFO - 'PAGER': '/bin/cat', 08:15:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:44 INFO - 'PWD': '/builds/slave/test', 08:15:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:44 INFO - 'SHELL': '/bin/bash', 08:15:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obsuLi75vm/Listeners', 08:15:44 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:15:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:44 INFO - 'USER': 'cltbld', 08:15:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:44 INFO - 'XPC_FLAGS': '0x0', 08:15:44 INFO - 'XPC_SERVICE_NAME': '0', 08:15:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:44 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)) 08:15:44 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)) 08:15:44 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)) 08:15:44 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)) 08:15:44 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)) 08:15:44 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)) 08:15:44 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)) 08:15:44 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)) 08:15:44 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)) 08:15:44 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)) 08:15:44 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)) 08:15:44 INFO - Cleaning up... 08:15:44 INFO - Return code: 0 08:15:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:15: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')]} 08:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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')]} 08:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104317570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb693c83940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041b5d30>, '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 0x10401bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041adb20>, '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.4UsUtRNOWB/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.obsuLi75vm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 08:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:15:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UsUtRNOWB/Render', 08:15:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:44 INFO - 'HOME': '/Users/cltbld', 08:15:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:44 INFO - 'LOGNAME': 'cltbld', 08:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:44 INFO - 'MOZ_NO_REMOTE': '1', 08:15:44 INFO - 'NO_EM_RESTART': '1', 08:15:44 INFO - 'PAGER': '/bin/cat', 08:15:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:44 INFO - 'PWD': '/builds/slave/test', 08:15:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:44 INFO - 'SHELL': '/bin/bash', 08:15:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obsuLi75vm/Listeners', 08:15:44 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:15:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:44 INFO - 'USER': 'cltbld', 08:15:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:44 INFO - 'XPC_FLAGS': '0x0', 08:15:44 INFO - 'XPC_SERVICE_NAME': '0', 08:15:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:15:45 INFO - Cleaning up... 08:15:45 INFO - Return code: 0 08:15:45 INFO - Running post-action listener: _resource_record_post_action 08:15:45 INFO - Running post-action listener: _start_resource_monitoring 08:15:45 INFO - Starting resource monitoring. 08:15:45 INFO - [mozharness: 2017-01-18 16:15:45.229040Z] Finished create-virtualenv step (success) 08:15:45 INFO - [mozharness: 2017-01-18 16:15:45.230026Z] Running install step. 08:15:45 INFO - Running pre-action listener: _resource_record_pre_action 08:15:45 INFO - Running main action method: install 08:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:45 INFO - Reading from file tmpfile_stdout 08:15:45 INFO - Detecting whether we're running mozinstall >=1.0... 08:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:15:45 INFO - Reading from file tmpfile_stdout 08:15:45 INFO - Output received: 08:15:45 INFO - Usage: mozinstall [options] installer 08:15:45 INFO - Options: 08:15:45 INFO - -h, --help show this help message and exit 08:15:45 INFO - -d DEST, --destination=DEST 08:15:45 INFO - Directory to install application into. [default: 08:15:45 INFO - "/builds/slave/test"] 08:15:45 INFO - --app=APP Application being installed. [default: firefox] 08:15:45 INFO - mkdir: /builds/slave/test/build/application 08:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:16:17 INFO - Reading from file tmpfile_stdout 08:16:17 INFO - Output received: 08:16:17 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:16:17 INFO - Running post-action listener: _resource_record_post_action 08:16:17 INFO - [mozharness: 2017-01-18 16:16:17.044865Z] Finished install step (success) 08:16:17 INFO - [mozharness: 2017-01-18 16:16:17.045005Z] Running run-tests step. 08:16:17 INFO - Running pre-action listener: _resource_record_pre_action 08:16:17 INFO - Running main action method: run_tests 08:16:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:16:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:16:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:16:17 INFO - 2017-01-18 08:16:17.059 screenresolution[1903:21026] starting screenresolution argv=screenresolution get 08:16:17 INFO - 2017-01-18 08:16:17.062 screenresolution[1903:21026] Display 0: 1600x1200x32@60 08:16:17 INFO - 2017-01-18 08:16:17.068 screenresolution[1904:21028] starting screenresolution argv=screenresolution list 08:16:17 INFO - Available Modes on Display 0 08:16:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:16:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:16:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:16:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:16:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:16:17 INFO - Intel Iris: 08:16:17 INFO - Chipset Model: Intel Iris 08:16:17 INFO - Type: GPU 08:16:17 INFO - Bus: Built-In 08:16:17 INFO - VRAM (Dynamic, Max): 1536 MB 08:16:17 INFO - Vendor: Intel (0x8086) 08:16:17 INFO - Device ID: 0x0a2e 08:16:17 INFO - Revision ID: 0x0009 08:16:17 INFO - Displays: 08:16:17 INFO - Display: 08:16:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:16:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:16:17 INFO - Display Serial Number: 1600x1200 60 08:16:17 INFO - Main Display: Yes 08:16:17 INFO - Mirror: Off 08:16:17 INFO - Online: Yes 08:16:17 INFO - Rotation: Supported 08:16:17 INFO - Return code: 0 08:16:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:16:17 INFO - Python 2.7.3 08:16:17 INFO - Return code: 0 08:16:17 INFO - grabbing minidump binary from tooltool 08:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:17 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 0x1041b5d30>, '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 0x10401bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041adb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:16:17 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 08:16:17 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 08:16:17 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 08:16:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:16:17 INFO - Return code: 0 08:16:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:16:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:16:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:16:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:16:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:16:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0379', '--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 08:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0379 --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 08:16:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UsUtRNOWB/Render', 08:16:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:17 INFO - 'HOME': '/Users/cltbld', 08:16:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:17 INFO - 'LOGNAME': 'cltbld', 08:16:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:16:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:17 INFO - 'MOZ_NO_REMOTE': '1', 08:16:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:16:17 INFO - 'NO_EM_RESTART': '1', 08:16:17 INFO - 'PAGER': '/bin/cat', 08:16:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:17 INFO - 'PWD': '/builds/slave/test', 08:16:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:16:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:17 INFO - 'SHELL': '/bin/bash', 08:16:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obsuLi75vm/Listeners', 08:16:17 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:16:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:17 INFO - 'USER': 'cltbld', 08:16:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:17 INFO - 'XPC_FLAGS': '0x0', 08:16:17 INFO - 'XPC_SERVICE_NAME': '0', 08:16:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0379', '--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 08:16:17 INFO - mozversion application_buildid: 20170118065326 08:16:17 INFO - mozversion application_changeset: 8a2f1d1241fa944e682e20650584921e1ca90e29 08:16:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:16:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:16:17 INFO - mozversion application_name: Firefox 08:16:17 INFO - mozversion application_remotingname: firefox-dev 08:16:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:16:17 INFO - mozversion application_vendor: Mozilla 08:16:17 INFO - mozversion application_version: 52.0a2 08:16:17 INFO - mozversion platform_buildid: 20170118065326 08:16:17 INFO - mozversion platform_changeset: 8a2f1d1241fa944e682e20650584921e1ca90e29 08:16:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:16:17 INFO - mozversion platform_version: 52.0a2 08:16:17 INFO - using testdate: 1484756177 08:16:17 INFO - actual date: 1484756177 08:16:17 INFO - starting webserver on 'localhost:56185' 08:16:17 INFO - SUITE-START | Running 2 tests 08:16:17 INFO - TEST-START | dromaeo_css 08:16:17 INFO - operating with platform_type : mac_ 08:16:17 INFO - Initialising browser for dromaeo_css test... 08:16:17 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmp6nuCH7/profile http://localhost:56185/getInfo.html) 08:16:20 INFO - PROCESS | 1914 | 2017-01-18 08:16:20.474 plugin-container[1916:21196] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 08:16:20 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:16:20 INFO - PROCESS | 1914 | 2017-01-18 08:16:20.478 plugin-container[1916:21196] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 08:16:20 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:16:20 INFO - PROCESS | 1914 | 2017-01-18 08:16:20.478 plugin-container[1916:21196] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:16:20 INFO - PROCESS | 1914 | __metrics Screen width/height:1600/1200 08:16:20 INFO - PROCESS | 1914 | colorDepth:24 08:16:20 INFO - PROCESS | 1914 | Browser inner width/height: 1024/689 08:16:20 INFO - PROCESS | 1914 | __metrics 08:16:20 ERROR - PROCESS | 1914 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 08:16:21 INFO - TEST-INFO | 1914: exit 0 08:16:21 INFO - Browser initialized. 08:16:21 INFO - Running cycle 1/1 for dromaeo_css test... 08:16:21 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmp6nuCH7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:23 INFO - PROCESS | 1917 | 2017-01-18 08:16:23.968 plugin-container[1918:21325] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x874b, name = 'com.apple.tsm.portname' 08:16:23 INFO - PROCESS | 1917 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:16:23 INFO - PROCESS | 1917 | 2017-01-18 08:16:23.969 plugin-container[1918:21325] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 08:16:23 INFO - PROCESS | 1917 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:16:23 INFO - PROCESS | 1917 | 2017-01-18 08:16:23.969 plugin-container[1918:21325] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:16:33 INFO - PROCESS | 1917 | RSS: Main: 228806656 08:16:33 INFO - PROCESS | 1917 | 08:19:36 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:56185/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56185/tests/dromaeo/cssquery-ext.html) 08:19:37 INFO - PROCESS | 1917 | RSS: Main: 234164224 08:19:37 INFO - PROCESS | 1917 | 08:22:40 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:56185/tests/dromaeo/cssquery-ext.html (next: http://localhost:56185/tests/dromaeo/cssquery-jquery.html) 08:22:40 INFO - PROCESS | 1917 | RSS: Main: 243609600 08:22:40 INFO - PROCESS | 1917 | 08:25:42 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:56185/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56185/tests/dromaeo/cssquery-mootools.html) 08:25:43 INFO - PROCESS | 1917 | RSS: Main: 250380288 08:25:43 INFO - PROCESS | 1917 | 08:28:45 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:56185/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56185/tests/dromaeo/cssquery-prototype.html) 08:28:45 INFO - PROCESS | 1917 | RSS: Main: 249696256 08:28:45 INFO - PROCESS | 1917 | 08:31:48 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:56185/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56185/tests/dromaeo/cssquery-yui.html) 08:31:49 INFO - PROCESS | 1917 | RSS: Main: 254160896 08:31:49 INFO - PROCESS | 1917 | 08:34:51 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:56185/tests/dromaeo/cssquery-yui.html (next: http://localhost:56185/tests/dromaeo/cssquery-dojo.html) 08:34:51 INFO - PROCESS | 1917 | RSS: Main: 255500288 08:34:51 INFO - PROCESS | 1917 | 08:34:51 INFO - PROCESS | 1917 | __start_tp_report 08:34:51 INFO - PROCESS | 1917 | _x_x_mozilla_page_load 08:34:51 INFO - PROCESS | 1917 | _x_x_mozilla_page_load_details 08:34:51 INFO - PROCESS | 1917 | |i|pagename|runs| 08:34:51 INFO - PROCESS | 1917 | |0;dojo.html;3313.6355000949893;3321.9501707474383;3337.532745415641;3343.3981883261017;3366.7306615470757;5572.86067848304;5608;5632;5665.206871038058;5680.233168522248;5621.7751289948355;5696.344920334162;5701.971490142543;5721.141828725693;5728.914066289009;5061.569766569837;5184.455632158626;5196.194589838581;5203.869903252411;5240.580753539708;5254.185601231796;5261.342332208474;5277.340332458442;5309.707966061865;5310.92033619496;5084.974575127119;5147.794088236466;5265.210218467222;5271.789128434858;5275.419703832595;5153.561947234452;5180.559652429548;5207.557357624606;5215.452377500345;5243.318368612075;5102.132637451642;5210.166373380241;5215.8174463893965;5274.5780337572905;5292.073887069748;5654.688992105433;5672.546196304285;5682.602217844753;5755.798547050875;5780.16187652788;5799.971000145015;5891.351951285355;5909.734061967179;5958.702064896738;5967.254093238345;6077.848053798646;6082.635041897456;6091.51267898567;6100.938990610126;6145.723442445101;5700.087985922274;5714.057180565202;5714.942850571524;5725.942740572541;5840.182374467578;6232.532560057924;6259.405356491126;6262.248530176408;6283.8114856554375;6284.4344009039405;5908.4091590841435;5961.940380596226;6113.5414843886;6134.079888016833;6136.048912418582;6059.909101363483;6088.665123418166;6131.286584637414;6132.877342453126;6171.043488259327;4959.975200123977;6077.027675571887;6093.11649810775;6096.573239873255;6140.723667434976;5941.881162376728;6090.969545152246;6096.451319381188;6098.786542470993;6123.877522449615;4835.734034628129;4869.245266983552;4876.536729010738;4898.975505122523;4929.827456039022;4324.243257429937;4327;4343.67422443318;4350.2387082260475;4371.978140109342;5021.673591216632;5659.094544872883;5805.94194058054;5824.796132135355;5829.213056237439;4374.4531933508315;6114.327782088734;6133.304060594615;6163.044728067157;6221.906671399933;5008.499150084962;5639.577031722637;5704.429557044263;5708.942910570924;5731.971340143273;4612.077584483117;5205.089109405839;5264.631475796734;5312.203169524602;5348.983693098299;6214.440700337082;6239.064140378798;6248.937510624835;6249.0626406039455;6287.779927702509;6200.914839902909;6207.255129384503;6218.5647004711045;6239.563230573998;6271.184745982993;6293.937060629335;6326.3989920959275;6331.9366806331345;6347.619142851444;6353.36466353361;5985.910211346921;6013.9699301503215;6035.818925432069;6087.634741915499;6131.202943617302;6271.905921411274;6286.057091436322;6295.087212354275;6300.023496357889;6306.054091886253;6079.696015199134;6088.086786981989;6095.420935011167;6115.541334399849;6122.142899993915;5708.54331653475;5745.396733342939;5871.823845284648;5951.464368206709;6100.725467353891;5593.300837395325;5649.152627105803;5668.093105103164;5688.40271771458;5688.63023903445;5797.333306669787;5798.768049277982;5798.768049277982;5818.010938140611;5833.912491312719;5671.489565939085;5694.800681976111;5723.227364305932;5739.569532285179;5847.356790753099 08:34:51 INFO - PROCESS | 1917 | |1;ext.html;490.8576512811285;492.54193599952055;493.48430889720237;518.1683398145977;535.2292698514142;38363.42454863176;39791.403128953054;39922.60077399225;41104.76685699434;41107;41110.58889411105;41498.377524337084;41500.37749433753;41656;41743.58256417435;9266.258699304039;9432.434053956784;9433.245340372754;9435.528223588828;9448.291378146632;9439.480828554426;9469.147776700096;9476.715698529055;9477.763055923622;9488.146066853982;9385.061493850595;9405.764855878624;9430.387024843363;9441.15029647335;9444.527773611326;9377.343585948985;9410.529473526296;9466.715998520056;9473.478958657237;9484.05159484053;9239.029901860342;9278;9310.86033709495;9364;9377.249820014451;39164.412533812014;39372.60627393718;39452.816415507295;39528.20943581141;39537.80231098855;3229.7254733347695;3242.8864989725485;3321.6014078310513;3661.2311414602964;3809.733318667694;28569.285767855763;29020.709792902013;29269.56095658567;29786.55320170199;30082.79668813245;3100.3489267253904;3173.3653269346223;3178.4278829810623;3184.617845858512;3204.9359012819846;461704;462860;468101;468490.6575467101;468726;58411;58804;58862;58886.527836804424;58948.11577826336;62941.68529157416;62995.05507417392;63266.0510092349;63404;63451.68274158692;15606.765898511305;15718;16047.759283610756;16085;16107.597310067107;10292.433916134534;12070.758584828254;12215.633530994084;12283.69290767738;12286.385680716106;17957;18481.260749570134;18516;18530.16614252362;18563.72154417685;7297.051383320135;7301.707931682779;7429.6596572079625;7504.598528470946;7541.509801862861;701.340739704676;806.2018601584389;851.5231470376609;971.7667759737753;990.5393991793707;25875.48249035009;27381.26187381246;28942.565861512096;29707.108786736433;29795.85102074519;974.5760594141572;1035.7203555040096;1049.3913530152493;1058.523664351045;1120.1934607082887;14759.376468588447;14763.114213147246;14854.331555080047;14952.626184345478;15135.697286054437;643404.7829760822;651601;654165;655316;657330;54552.45447545553;54837.725811370685;54885.725571372684;54968.45031549713;55628;1329.7872340425486;1341.1349679456891;1349.0354396606474;1362.7070179911366;1367.6170672211797;27305.180844574694;28166;28439.11470251003;28655.14034578966;28805.7119428803;47420;48219;48229;48266.034679305514;48367;518113;586284;607233;613082;613776;25742.613860792477;25983.480330393664;26808;26883.731162688906;27606.72393276122;44674.3298850524;44919.77540112409;44947.32579011252;45637.54362456333;45662.77168614136;37029.44455833219;37107.6289237115;37847.43228851625;38157.427638584886;38802;37445.4383184247;37564.43653345147;38260.808695956344;38646.420303694904;38715.8385248443;32900.01299961005;36414.72548460791;36736;37152.62847371492;37231;28618.57072143878;32462.67537324691;34036.319273614885;34104.97685069452;34256.48615270723;24951.376215594755;25224.74775252224;25449.765220812445;25508.872455638346;25565.872170639028 08:34:51 INFO - PROCESS | 1917 | |2;jquery.html;360.6663835951746;366.1121779684265;370.792356280483;375.64126259422255;391.5849199848161;17376.391826286083;17977.640447191065;18577.442676719686;18583.25666973323;19568.608627827434;15578.532644020697;18478.353257635987;19253.133608987595;19274.229030838786;19391.612167756673;5821;6078.817635470943;6086.665233412183;6100.054491553817;6119.5104391648565;4975.2039673652225;5662.320521537421;5993.011153159723;5998.4001599839885;6002.819915402523;5847.5029622481925;5878.706064696748;5893.38119497453;5930.021546444831;5934.080217566263;5666.263385759846;5883.764649414018;5960.761569537213;6038.879222415527;6088.208532890696;4966.627502937295;5242.6330156889035;5850.941490585083;5863.149843272744;5886.411358864122;12464;12536;12669.429875655618;12719.427625756864;16539.751903721455;2234.642457206839;2265.184533567914;2408.638704194367;2661.38788078743;2799.678037025748;9535.570899309549;9784.364016338915;10052.547635356426;11742.471588778526;14954.953153279275;1419.8012278281049;1850.9167087481096;1863.2453856188265;1868.8785228960073;1876.2307453943954;100215.49892250565;105493;107022;122966;126657.73342266552;9453.669121580711;10842.403667798348;11261.155413343868;11653.6503904883;11688.649340519798;14038.508652197124;14111.858881411259;14318.355673994694;14325.212113333866;14434.206118663575;7821.530708157528;8272.503649781032;8274.420790544604;8370.246677799027;8375.539345336065;7481.738139165212;8093.635786389626;8204.015518137743;8242.752717418487;8361.707340243061;4421.977890110593;4458.643308535309;4460;4472.195004899084;4541.75020373876;1887.1507821480388;1934.1876411907033;1934.7001214811446;1935.1968932892692;1946.5133716570858;820.9220124088203;847.656699036891;856.4775486952954;883.9646414143363;927.9304052195977;19707;20710.896445517676;20762.89618551928;20894.37316880496;21201.893990530258;874.9606267717968;909.1726528858838;909.977250568741;925.6991477769752;940.4827344960381;9372.39079459833;10566.894331056592;10696.732581685364;10886.72783180411;10945.726356841144;564966;570711;585193;585334;585643;109502;110313.44843275732;123165;125356;127390.10113880734;939.4175611121012;964.2719746591279;988.560090759605;992.3004281981185;995.9103680668775;18340.81659183391;18853.528661783566;19059.523511912314;19086.904565477085;19113.044347782834;55132;55271.72364138153;55879.44120558743;56225.43774562202;57559.71220143873;69058.30941690519;74412.62793685996;75342.86985695109;76585.61707191428;78117;7547.433942454448;7922.0889597694695;8007.919920800718;8082.676692932217;8272.965879265092;11813.40932953366;12471.875281247072;12598.87401125977;12729.681757956125;12753.808692869428;8734.475931444134;9906.257030722869;10156.746081348025;10183.847242291224;10817;8706.738797836075;8852.690155844515;9432.717018489457;10195.84706229422;10951.945240273748;9254.167124958516;9425.858612120961;10802.161429254977;10927.07119894786;11757.470913808727;8063.072746634212;8175.059868115243;8222.506649601042;8288.875666865122;8321.41750077513;9078.727638170865;9781.804363912825;11024.653618643084;11084.334939903632;11172.888271117185 08:34:51 INFO - PROCESS | 1917 | |3;mootools.html;1446.4575784080969;1474.5060404764404;1621.505440840544;1738.5305967388813;1768.1601239411289;6673.599584024962;7550;7780.377569794417;8534.573271336432;8562.015368232647;7990.280874721274;8270.421070525066;8278.503289802617;8391.412601117909;8414.116517765638;2286.88565571722;2321.8955147018423;2325.0699720112007;2325.360525855395;2334.533093381322;2320.825938054644;2342.367560758603;2343.484433424644;2355.5995480768224;2372.632242002484;2188.9233876814314;2190.1896298369625;2205.4155648753094;2211.6793065005645;2229.9665505017356;2254.875981820999;2265.9773402266014;2282.4408020035116;2288.3821368230483;2290.4273931517123;1938.4766113149512;2310.2260742651233;2319.9072037118663;2348.236823032504;2350.8589484630975;8305.584720763938;8368.832623347498;8420.326373890073;8427.367947403969;8453.323734101257;5073.923891141636;5221.530062294411;5228;5245.291885595434;5247.344081989751;3223.9677603223904;3226.806391616487;3292.9506057409158;3483.2583708145926;3550.0592343029116;1035.761774791802;1054.0618849224197;1058.8623478947688;1063.7234319077018;1097.1661537231682;10760.56957721698;10784.191185661028;10796.784064318748;10882.183836212236;10893.019628233496;3946.743461674982;4518.457785065747;4612.962083531179;4768.451628062817;4775.116603428308;9333.346665733334;9417.811643767087;9429.198518126037;9433.90566094344;9451.29115316354;5173.586113110942;5176.249443830623;5193.091209038404;5202.115640341151;5211.374635043819;4245.830166793356;4300.301740503165;4677.087967846237;4742.312364707167;4751.121042607128;3421.8802341918413;3776.244751049746;3821.9617803821607;3857.4406711026745;3924.2543916656314;1262.501311981762;1272.2175861845083;1273.4587800184884;1279.7632437999;1292.7349893271858;754.5925200391727;854.1757204297758;895.8790563274005;898.1243287794348;912.3476714149282;4764.380630518011;5636.351819540723;5809.24479817621;5835.503982161564;5872.067463330823;841.3731769831514;920.2086205862953;929.9767505812409;944.527736131934;955.3169483819103;3576.5886923004186;3713.9071523212137;3759.962400376016;3792.6776224020714;3805.086779173034;8464.365172611955;9812.705618831447;10024.649137280307;10149.137323327452;10170.644027459004;8399.454035487674;10034;10077.798444031077;10085.041921017491;10110.988901109977;7507.1366792818435;7708.807279818049;7828.2954534092205;7874.173211812792;7986.560739159286;5712.171735098471;5732.828015159552;5843.094320380348;5882.735276912635;5990.430909063632;8128.9593552031865;9244.676436324697;9289.256859451092;9414.62341506332;9442.48066356357;9053.004169541477;9381.859272110787;9445.102715242041;9484;9512.1439070484;6649.268580456049;6708.731650733916;6830.077939478107;6841.521093523605;6954.756583519553;7744.961275193813;7978.321842643209;7987.361011119213;7998.520088794691;8000.599970001593;6024.548158888013;6031.638101713911;7170.9960605514225;7197.82005449847;7239.4932354734665;6085.752420753646;6833.829154271183;6970.059042029261;7056.894146587702;7097.858042839011;5729.197912292366;6511.544191906711;6633.402993730588;6691.966540167268;6717.05961165447;4717.905641887074;4744.667873248977;4770.666053376231;4793.760311984456;4838.588719958843;4762.785674644719;4793.544613261734;4803.279508073817;4872.317875497362;4887 08:34:51 INFO - PROCESS | 1917 | |4;prototype.html;274.58948871437207;299.186213499282;308.134143058007;309.3272133110484;311.49071268476035;4957.454679985199;5008.724520151395;5268.89135410108;5400.324959380077;5493.901219756055;5273.446288139748;5403.297571315733;5442.346918369792;5456.699881506515;5496.780128794843;3754.3992961126223;4094.4472496213075;4167.4790651168605;4169.270377683908;4182.477190351206;3352.9497057544036;4079.938800917989;4121.629053385194;4167.937480937789;4193.993441574031;3411.317736452707;3619.239959608485;4119.196756632457;4128.1330920506725;4136.482939632546;3775.716256472785;4121.5466298707115;4132.979335103335;4152.875413737593;4172.853950111731;3462.3248466549035;3630.3102410541915;3634.60019397866;3656.4149736042104;3657.104009517685;4793.304970779218;4956.801727930879;5359.461457022466;5361.0618141825025;5383.757730902119;3696.1868388954385;3962.841486340543;4127.7936103194725;4606.894345357124;4726.998356043902;5723;5737.254156959611;5741.511971482429;5742.483176514092;5807.680577568232;3386.9661303386897;3552.431610942237;3712.576639754573;3885.9611403885883;3922.2155568886337;5185.844424667266;6039.520317522235;6072.483838873701;6075.574709770318;6171.59884607499;3317.983410082934;3955.9121241658772;3959.7030222732833;3975.20495900821;3989.84040638377;3196.856141473639;3955.20895820837;3977.6817854571564;4003.8798836034966;4015.3976903464713;4153.68847336451;4628.699134556243;4641.9555599989735;4642.767861606973;4671.416072990876;5158.123119069767;5793.362730099686;5813.883722325614;5850.473457388855;5862.856742935087;1162.7733040811815;1220.9621821451694;1257.8239046533492;1258.7671280813079;1274.1463219642862;678.8811957907346;782.1787123520281;860.5568132411813;862.4868203418956;885.106042896679;4431.689781715249;4635.519996801695;4923.606111511142;5075.492450754895;5121.231815227671;5369.060414427459;5478.192196575121;5598.272224610774;5653.236813030188;5707.343655479673;4624.86690760759;4879.463259041502;5129.589632829365;5138.511841375063;5143.3570803649545;2441.694788151481;2730.447032025063;2856.757175640052;2883.408901175254;2965.481040817848;4810.8797280068275;4858.78135483904;5842.298924129047;5860.560457965669;5865.706714664249;4511.796969136397;4943.5797957174045;5498.532624726863;5691.430856914276;5776.68228247442;5044.713598032478;5114.488551145005;5710.086386178275;5743.913841292384;5784.223572685219;4319.719218250803;4476.731396116244;5135.87160320995;5184.96300739846;5631.408702086222;4528.6377089833395;5191.158542678466;5393.97514472249;5482.835514934558;5533.889322213453;4845.200541910545;4978.8755281118265;5064.265681476239;5146.716930568855;5535.944640553704;3294.8517316720327;3665.633436656313;3725.720570957243;3741.9064523387133;3748.7001039917286;5198.818041368534;5497.8075767347955;5554.972539965809;5574.247476590608;5630.507915402503;5358.705271210121;5553.416891226363;5651.237082993744;5729.455701708331;5831.912521312099;4646.558576935186;5054.646174767878;5762.328924611816;5818.76724930998;5857.619254748598;4467.441569803775;5374.193870919394;5614.63504872182;5690.260266165372;5695.971520142372;5675.602707810579;5747.396523365153;5764.385971927867;5769.798057067983;5787.536997040311;5655.501292157664;5665.943340566707;5696.515796157373;5715.742791574306;5717.571182161271 08:34:51 INFO - PROCESS | 1917 | |5;yui.html;670.1321788284172;674.6795272245687;682.7061074788709;739.3124394313287;743.8549482850844;13886.097403668768;14812.11127332358;14814.925925370386;14827.77758333626;14837.554873353789;10906.61826836061;13232.33838308083;13333.666658333523;13351.399187036583;13357.398917048731;623.3392603839922;647.685872351909;773.717593078525;790.5849429049738;806.3629732511309;808.4906508899414;808.8220591469897;810.1817164663703;810.5541951926447;810.8702607582788;849.6134258912211;850.2093053460279;854.679495189304;855.9229669329759;856.6316483911916;839.1063517354029;845.8477474054637;846.9237768600856;847.7541512961265;849.2950850793826;622.4895585619794;628.6605233174126;632.0708558419117;635.891898377277;637.3148864970176;13555.45778168882;13876.58370248894;13903.79144312826;13916.860831391657;14272.571822845332;11212.775744485065;13364.131331463424;13536.390862411117;14006.789898151535;14022.158670479805;10490.58037678492;10931.125509959184;11178.44107794607;11210.159238057096;11467.713307167303;4319.654427645781;4335.5014173370155;4380.167768124046;4421.135623075713;4425.778711064434;84212.3157536852;86556;86723.56638216769;87942.12057879403;89413.55293223557;9947.154491868272;10164.695059148238;10169.593216271414;10192.439415832201;10204.336718113298;18817.341393051178;18968;18984.14571344293;19093;19130.330438434587;6926.930730692729;7148.749793757193;7287.744928927462;7324.08448943882;7446.180920098785;3447.9655203447646;3744.251149770057;3750.8124593770203;4192.161567686475;4265.91468170641;3278.770461077096;3527.6825085742407;3696.2607478504406;3699.926001479955;3732.738708290394;554.2822045451151;661.685699292832;685.0683071023404;694.2883544367064;697.6790676288964;561.3123923194137;569.4133752622664;624.8843963866699;646.5991085527004;662.8972509261072;7705.075390953121;7741.458097933203;8556.224548429786;9140.54297285133;9250.398724082914;558.4861927027144;596.6151832068379;606.836154238362;617.4813156948185;643.9195100612424;4290.957090429119;4476.910461790746;4479.260921947907;4483.036147228297;4498.527654596221;51426.74286628543;68941.96587051198;69783.65108174528;78672;100609;74276.62861685765;77822.2217777815;78913.25499588378;93178;97321.51339243258;59795;79822.20177798264;86293;86519;86706.1329386698;9396.107369799858;9637.662681806103;9698.46658433793;9763.316567840184;9769.120779129627;54227.72886135544;54250;54488.72755636196;54949.17576236439;55614.44385556092;49278.260826086924;49863;54050.72974635102;75863;78412;12471.069833827869;12509.186902851285;12519.248845069325;12553.995680345733;12849.743005140032;13723.862761372258;13724.862751372359;13886.236257005961;14133.293335333397;14329.068610540282;12816.487340506275;12861.2926289055;13060.21638701681;13141.934290328487;13176.868231317565;12498.750024999266;12576.182548134342;12651.493940242288;13065;13236.801447978096;12479.56321528742;12672.239665620093;12785.424655890693;13010.414531346301;13257.867421325664;10803.945980270048;11024.062954648945;11370.431478426211;11431.314121152758;11520.251183673034;11167.49746261404;11223.214374993671;11397.715057123638;11415.315081094828;11422.94288528552 08:34:51 INFO - PROCESS | 1917 | __end_tp_report 08:34:51 INFO - PROCESS | 1917 | __start_cc_report 08:34:51 INFO - PROCESS | 1917 | _x_x_mozilla_cycle_collect,363 08:34:51 INFO - PROCESS | 1917 | __end_cc_report 08:34:51 INFO - PROCESS | 1917 | __startTimestamp1484757291863__endTimestamp 08:34:51 INFO - PROCESS | 1917 | 08:34:51 INFO - PROCESS | 1917 | ------- Summary: start ------- 08:34:51 INFO - PROCESS | 1917 | Number of tests: 6 08:34:51 INFO - PROCESS | 1917 | 08:34:51 INFO - PROCESS | 1917 | [#0] dojo.html Cycles:165 Average:5644.51 Median:5755.80 stddev:634.14 (11.0%) stddev-sans-first:609.16 08:34:51 INFO - PROCESS | 1917 | Values: 3313.6 3322.0 3337.5 3343.4 3366.7 5572.9 5608.0 5632.0 5665.2 5680.2 5621.8 5696.3 5702.0 5721.1 5728.9 5061.6 5184.5 5196.2 5203.9 5240.6 5254.2 5261.3 5277.3 5309.7 5310.9 5085.0 5147.8 5265.2 5271.8 5275.4 5153.6 5180.6 5207.6 5215.5 5243.3 5102.1 5210.2 5215.8 5274.6 5292.1 5654.7 5672.5 5682.6 5755.8 5780.2 5800.0 5891.4 5909.7 5958.7 5967.3 6077.8 6082.6 6091.5 6100.9 6145.7 5700.1 5714.1 5714.9 5725.9 5840.2 6232.5 6259.4 6262.2 6283.8 6284.4 5908.4 5961.9 6113.5 6134.1 6136.0 6059.9 6088.7 6131.3 6132.9 6171.0 4960.0 6077.0 6093.1 6096.6 6140.7 5941.9 6091.0 6096.5 6098.8 6123.9 4835.7 4869.2 4876.5 4899.0 4929.8 4324.2 4327.0 4343.7 4350.2 4372.0 5021.7 5659.1 5805.9 5824.8 5829.2 4374.5 6114.3 6133.3 6163.0 6221.9 5008.5 5639.6 5704.4 5708.9 5732.0 4612.1 5205.1 5264.6 5312.2 5349.0 6214.4 6239.1 6248.9 6249.1 6287.8 6200.9 6207.3 6218.6 6239.6 6271.2 6293.9 6326.4 6331.9 6347.6 6353.4 5985.9 6014.0 6035.8 6087.6 6131.2 6271.9 6286.1 6295.1 6300.0 6306.1 6079.7 6088.1 6095.4 6115.5 6122.1 5708.5 5745.4 5871.8 5951.5 6100.7 5593.3 5649.2 5668.1 5688.4 5688.6 5797.3 5798.8 5798.8 5818.0 5833.9 5671.5 5694.8 5723.2 5739.6 5847.4 08:34:51 INFO - PROCESS | 1917 | 08:34:51 INFO - PROCESS | 1917 | [#1] ext.html Cycles:180 Average:69604.15 Median:39857.00 stddev:153660.89 (385.5%) stddev-sans-first:154004.33 08:34:51 INFO - PROCESS | 1917 | Values: 490.9 492.5 493.5 518.2 535.2 38363.4 39791.4 39922.6 41104.8 41107.0 41110.6 41498.4 41500.4 41656.0 41743.6 9266.3 9432.4 9433.2 9435.5 9448.3 9439.5 9469.1 9476.7 9477.8 9488.1 9385.1 9405.8 9430.4 9441.2 9444.5 9377.3 9410.5 9466.7 9473.5 9484.1 9239.0 9278.0 9310.9 9364.0 9377.2 39164.4 39372.6 39452.8 39528.2 39537.8 3229.7 3242.9 3321.6 3661.2 3809.7 28569.3 29020.7 29269.6 29786.6 30082.8 3100.3 3173.4 3178.4 3184.6 3204.9 461704.0 462860.0 468101.0 468490.7 468726.0 58411.0 58804.0 58862.0 58886.5 58948.1 62941.7 62995.1 63266.1 63404.0 63451.7 15606.8 15718.0 16047.8 16085.0 16107.6 10292.4 12070.8 12215.6 12283.7 12286.4 17957.0 18481.3 18516.0 18530.2 18563.7 7297.1 7301.7 7429.7 7504.6 7541.5 701.3 806.2 851.5 971.8 990.5 25875.5 27381.3 28942.6 29707.1 29795.9 974.6 1035.7 1049.4 1058.5 1120.2 14759.4 14763.1 14854.3 14952.6 15135.7 643404.8 651601.0 654165.0 655316.0 657330.0 54552.5 54837.7 54885.7 54968.5 55628.0 1329.8 1341.1 1349.0 1362.7 1367.6 27305.2 28166.0 28439.1 28655.1 28805.7 47420.0 48219.0 48229.0 48266.0 48367.0 518113.0 586284.0 607233.0 613082.0 613776.0 25742.6 25983.5 26808.0 26883.7 27606.7 44674.3 44919.8 44947.3 45637.5 45662.8 37029.4 37107.6 37847.4 38157.4 38802.0 37445.4 37564.4 38260.8 38646.4 38715.8 32900.0 36414.7 36736.0 37152.6 37231.0 28618.6 32462.7 34036.3 34105.0 34256.5 24951.4 25224.7 25449.8 25508.9 25565.9 08:34:51 INFO - PROCESS | 1917 | 08:34:51 INFO - PROCESS | 1917 | [#2] jquery.html Cycles:180 Average:33492.04 Median:4506.97 stddev:96473.49 (2140.5%) stddev-sans-first:96712.05 08:34:51 INFO - PROCESS | 1917 | Values: 360.7 366.1 370.8 375.6 391.6 17376.4 17977.6 18577.4 18583.3 19568.6 15578.5 18478.4 19253.1 19274.2 19391.6 5821.0 6078.8 6086.7 6100.1 6119.5 4975.2 5662.3 5993.0 5998.4 6002.8 5847.5 5878.7 5893.4 5930.0 5934.1 5666.3 5883.8 5960.8 6038.9 6088.2 4966.6 5242.6 5850.9 5863.1 5886.4 12464.0 12536.0 12669.4 12719.4 16539.8 2234.6 2265.2 2408.6 2661.4 2799.7 9535.6 9784.4 10052.5 11742.5 14955.0 1419.8 1850.9 1863.2 1868.9 1876.2 100215.5 105493.0 107022.0 122966.0 126657.7 9453.7 10842.4 11261.2 11653.7 11688.6 14038.5 14111.9 14318.4 14325.2 14434.2 7821.5 8272.5 8274.4 8370.2 8375.5 7481.7 8093.6 8204.0 8242.8 8361.7 4422.0 4458.6 4460.0 4472.2 4541.8 1887.2 1934.2 1934.7 1935.2 1946.5 820.9 847.7 856.5 884.0 927.9 19707.0 20710.9 20762.9 20894.4 21201.9 875.0 909.2 910.0 925.7 940.5 9372.4 10566.9 10696.7 10886.7 10945.7 564966.0 570711.0 585193.0 585334.0 585643.0 109502.0 110313.4 123165.0 125356.0 127390.1 939.4 964.3 988.6 992.3 995.9 18340.8 18853.5 19059.5 19086.9 19113.0 55132.0 55271.7 55879.4 56225.4 57559.7 69058.3 74412.6 75342.9 76585.6 78117.0 7547.4 7922.1 8007.9 8082.7 8273.0 11813.4 12471.9 12598.9 12729.7 12753.8 8734.5 9906.3 10156.7 10183.8 10817.0 8706.7 8852.7 9432.7 10195.8 10951.9 9254.2 9425.9 10802.2 10927.1 11757.5 8063.1 8175.1 8222.5 8288.9 8321.4 9078.7 9781.8 11024.7 11084.3 11172.9 08:34:51 INFO - PROCESS | 1917 | 08:34:51 INFO - PROCESS | 1917 | [#3] mootools.html Cycles:180 Average:5378.73 Median:5184.67 stddev:2938.23 (56.7%) stddev-sans-first:2931.61 08:34:51 INFO - PROCESS | 1917 | Values: 1446.5 1474.5 1621.5 1738.5 1768.2 6673.6 7550.0 7780.4 8534.6 8562.0 7990.3 8270.4 8278.5 8391.4 8414.1 2286.9 2321.9 2325.1 2325.4 2334.5 2320.8 2342.4 2343.5 2355.6 2372.6 2188.9 2190.2 2205.4 2211.7 2230.0 2254.9 2266.0 2282.4 2288.4 2290.4 1938.5 2310.2 2319.9 2348.2 2350.9 8305.6 8368.8 8420.3 8427.4 8453.3 5073.9 5221.5 5228.0 5245.3 5247.3 3224.0 3226.8 3293.0 3483.3 3550.1 1035.8 1054.1 1058.9 1063.7 1097.2 10760.6 10784.2 10796.8 10882.2 10893.0 3946.7 4518.5 4613.0 4768.5 4775.1 9333.3 9417.8 9429.2 9433.9 9451.3 5173.6 5176.2 5193.1 5202.1 5211.4 4245.8 4300.3 4677.1 4742.3 4751.1 3421.9 3776.2 3822.0 3857.4 3924.3 1262.5 1272.2 1273.5 1279.8 1292.7 754.6 854.2 895.9 898.1 912.3 4764.4 5636.4 5809.2 5835.5 5872.1 841.4 920.2 930.0 944.5 955.3 3576.6 3713.9 3760.0 3792.7 3805.1 8464.4 9812.7 10024.6 10149.1 10170.6 8399.5 10034.0 10077.8 10085.0 10111.0 7507.1 7708.8 7828.3 7874.2 7986.6 5712.2 5732.8 5843.1 5882.7 5990.4 8129.0 9244.7 9289.3 9414.6 9442.5 9053.0 9381.9 9445.1 9484.0 9512.1 6649.3 6708.7 6830.1 6841.5 6954.8 7745.0 7978.3 7987.4 7998.5 8000.6 6024.5 6031.6 7171.0 7197.8 7239.5 6085.8 6833.8 6970.1 7056.9 7097.9 5729.2 6511.5 6633.4 6692.0 6717.1 4717.9 4744.7 4770.7 4793.8 4838.6 4762.8 4793.5 4803.3 4872.3 4887.0 08:34:51 INFO - PROCESS | 1917 | 08:34:51 INFO - PROCESS | 1917 | [#4] prototype.html Cycles:180 Average:4497.62 Median:5049.68 stddev:1402.36 (27.8%) stddev-sans-first:1370.00 08:34:51 INFO - PROCESS | 1917 | Values: 274.6 299.2 308.1 309.3 311.5 4957.5 5008.7 5268.9 5400.3 5493.9 5273.4 5403.3 5442.3 5456.7 5496.8 3754.4 4094.4 4167.5 4169.3 4182.5 3352.9 4079.9 4121.6 4167.9 4194.0 3411.3 3619.2 4119.2 4128.1 4136.5 3775.7 4121.5 4133.0 4152.9 4172.9 3462.3 3630.3 3634.6 3656.4 3657.1 4793.3 4956.8 5359.5 5361.1 5383.8 3696.2 3962.8 4127.8 4606.9 4727.0 5723.0 5737.3 5741.5 5742.5 5807.7 3387.0 3552.4 3712.6 3886.0 3922.2 5185.8 6039.5 6072.5 6075.6 6171.6 3318.0 3955.9 3959.7 3975.2 3989.8 3196.9 3955.2 3977.7 4003.9 4015.4 4153.7 4628.7 4642.0 4642.8 4671.4 5158.1 5793.4 5813.9 5850.5 5862.9 1162.8 1221.0 1257.8 1258.8 1274.1 678.9 782.2 860.6 862.5 885.1 4431.7 4635.5 4923.6 5075.5 5121.2 5369.1 5478.2 5598.3 5653.2 5707.3 4624.9 4879.5 5129.6 5138.5 5143.4 2441.7 2730.4 2856.8 2883.4 2965.5 4810.9 4858.8 5842.3 5860.6 5865.7 4511.8 4943.6 5498.5 5691.4 5776.7 5044.7 5114.5 5710.1 5743.9 5784.2 4319.7 4476.7 5135.9 5185.0 5631.4 4528.6 5191.2 5394.0 5482.8 5533.9 4845.2 4978.9 5064.3 5146.7 5535.9 3294.9 3665.6 3725.7 3741.9 3748.7 5198.8 5497.8 5555.0 5574.2 5630.5 5358.7 5553.4 5651.2 5729.5 5831.9 4646.6 5054.6 5762.3 5818.8 5857.6 4467.4 5374.2 5614.6 5690.3 5696.0 5675.6 5747.4 5764.4 5769.8 5787.5 5655.5 5665.9 5696.5 5715.7 5717.6 08:34:51 INFO - PROCESS | 1917 | 08:34:51 INFO - PROCESS | 1917 | [#5] yui.html Cycles:180 Average:18661.91 Median:49570.63 stddev:25938.85 (52.3%) stddev-sans-first:25976.43 08:34:51 INFO - PROCESS | 1917 | Values: 670.1 674.7 682.7 739.3 743.9 13886.1 14812.1 14814.9 14827.8 14837.6 10906.6 13232.3 13333.7 13351.4 13357.4 623.3 647.7 773.7 790.6 806.4 808.5 808.8 810.2 810.6 810.9 849.6 850.2 854.7 855.9 856.6 839.1 845.8 846.9 847.8 849.3 622.5 628.7 632.1 635.9 637.3 13555.5 13876.6 13903.8 13916.9 14272.6 11212.8 13364.1 13536.4 14006.8 14022.2 10490.6 10931.1 11178.4 11210.2 11467.7 4319.7 4335.5 4380.2 4421.1 4425.8 84212.3 86556.0 86723.6 87942.1 89413.6 9947.2 10164.7 10169.6 10192.4 10204.3 18817.3 18968.0 18984.1 19093.0 19130.3 6926.9 7148.7 7287.7 7324.1 7446.2 3448.0 3744.3 3750.8 4192.2 4265.9 3278.8 3527.7 3696.3 3699.9 3732.7 554.3 661.7 685.1 694.3 697.7 561.3 569.4 624.9 646.6 662.9 7705.1 7741.5 8556.2 9140.5 9250.4 558.5 596.6 606.8 617.5 643.9 4291.0 4476.9 4479.3 4483.0 4498.5 51426.7 68942.0 69783.7 78672.0 100609.0 74276.6 77822.2 78913.3 93178.0 97321.5 59795.0 79822.2 86293.0 86519.0 86706.1 9396.1 9637.7 9698.5 9763.3 9769.1 54227.7 54250.0 54488.7 54949.2 55614.4 49278.3 49863.0 54050.7 75863.0 78412.0 12471.1 12509.2 12519.2 12554.0 12849.7 13723.9 13724.9 13886.2 14133.3 14329.1 12816.5 12861.3 13060.2 13141.9 13176.9 12498.8 12576.2 12651.5 13065.0 13236.8 12479.6 12672.2 12785.4 13010.4 13257.9 10803.9 11024.1 11370.4 11431.3 11520.3 11167.5 11223.2 11397.7 11415.3 11422.9 08:34:51 INFO - PROCESS | 1917 | -------- Summary: end -------- 08:34:51 INFO - PROCESS | 1917 | 08:34:52 INFO - TEST-INFO | 1917: exit 0 08:34:52 INFO - TEST-OK | dromaeo_css | took 1114878ms 08:34:52 INFO - TEST-START | kraken 08:34:52 INFO - operating with platform_type : mac_ 08:34:52 INFO - Initialising browser for kraken test... 08:34:52 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpzWBMtK/profile http://localhost:56185/getInfo.html) 08:34:55 INFO - PROCESS | 1922 | 2017-01-18 08:34:55.356 plugin-container[1923:23275] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434f, name = 'com.apple.tsm.portname' 08:34:55 INFO - PROCESS | 1922 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:34:55 INFO - PROCESS | 1922 | 2017-01-18 08:34:55.359 plugin-container[1923:23275] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 08:34:55 INFO - PROCESS | 1922 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:34:55 INFO - PROCESS | 1922 | 2017-01-18 08:34:55.359 plugin-container[1923:23275] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:34:55 INFO - PROCESS | 1922 | __metrics Screen width/height:1600/1200 08:34:55 INFO - PROCESS | 1922 | colorDepth:24 08:34:55 INFO - PROCESS | 1922 | Browser inner width/height: 1024/689 08:34:55 INFO - PROCESS | 1922 | __metrics 08:34:55 ERROR - PROCESS | 1922 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 08:34:56 INFO - TEST-INFO | 1922: exit 0 08:34:56 INFO - Browser initialized. 08:34:56 INFO - Running cycle 1/1 for kraken test... 08:34:56 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpzWBMtK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:59 INFO - PROCESS | 1924 | 2017-01-18 08:34:59.198 plugin-container[1925:23413] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 08:34:59 INFO - PROCESS | 1924 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:34:59 INFO - PROCESS | 1924 | 2017-01-18 08:34:59.199 plugin-container[1925:23413] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441b, name = 'com.apple.CFPasteboardClient' 08:34:59 INFO - PROCESS | 1924 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:34:59 INFO - PROCESS | 1924 | 2017-01-18 08:34:59.199 plugin-container[1925:23413] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:35:08 INFO - PROCESS | 1924 | RSS: Main: 228929536 08:35:08 INFO - PROCESS | 1924 | 08:35:11 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:56185/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56185/tests/kraken/driver.html?testName=audio-beat-detection) 08:35:12 INFO - PROCESS | 1924 | RSS: Main: 241242112 08:35:12 INFO - PROCESS | 1924 | 08:35:15 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:56185/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56185/tests/kraken/driver.html?testName=audio-dft) 08:35:15 INFO - PROCESS | 1924 | RSS: Main: 249290752 08:35:15 INFO - PROCESS | 1924 | 08:35:19 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:56185/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56185/tests/kraken/driver.html?testName=audio-fft) 08:35:19 INFO - PROCESS | 1924 | RSS: Main: 253112320 08:35:19 INFO - PROCESS | 1924 | 08:35:21 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:56185/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56185/tests/kraken/driver.html?testName=audio-oscillator) 08:35:22 INFO - PROCESS | 1924 | RSS: Main: 253374464 08:35:22 INFO - PROCESS | 1924 | 08:35:24 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:56185/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56185/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:35:25 INFO - PROCESS | 1924 | RSS: Main: 253349888 08:35:25 INFO - PROCESS | 1924 | 08:35:28 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:56185/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56185/tests/kraken/driver.html?testName=imaging-darkroom) 08:35:28 INFO - PROCESS | 1924 | RSS: Main: 257761280 08:35:28 INFO - PROCESS | 1924 | 08:35:31 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:56185/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56185/tests/kraken/driver.html?testName=imaging-desaturate) 08:35:32 INFO - PROCESS | 1924 | RSS: Main: 258314240 08:35:32 INFO - PROCESS | 1924 | 08:35:35 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:56185/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56185/tests/kraken/driver.html?testName=json-parse-financial) 08:35:35 INFO - PROCESS | 1924 | RSS: Main: 258347008 08:35:35 INFO - PROCESS | 1924 | 08:35:37 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:56185/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56185/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:35:38 INFO - PROCESS | 1924 | RSS: Main: 257638400 08:35:38 INFO - PROCESS | 1924 | 08:35:40 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:56185/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56185/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:35:40 INFO - PROCESS | 1924 | RSS: Main: 257564672 08:35:40 INFO - PROCESS | 1924 | 08:35:42 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:56185/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56185/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:35:43 INFO - PROCESS | 1924 | RSS: Main: 257626112 08:35:43 INFO - PROCESS | 1924 | 08:35:46 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:56185/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:35:47 INFO - PROCESS | 1924 | RSS: Main: 257921024 08:35:47 INFO - PROCESS | 1924 | 08:35:50 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:56185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:35:51 INFO - PROCESS | 1924 | RSS: Main: 258043904 08:35:51 INFO - PROCESS | 1924 | 08:35:52 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:56185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56185/tests/kraken/driver.html?testName=ai-astar) 08:35:53 INFO - PROCESS | 1924 | RSS: Main: 259592192 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | __start_tp_report 08:35:53 INFO - PROCESS | 1924 | _x_x_mozilla_page_load 08:35:53 INFO - PROCESS | 1924 | _x_x_mozilla_page_load_details 08:35:53 INFO - PROCESS | 1924 | |i|pagename|runs| 08:35:53 INFO - PROCESS | 1924 | |0;ai-astar;116;120;117;118;118;118;117;115;119;118 08:35:53 INFO - PROCESS | 1924 | |1;audio-beat-detection;170;145;144;148;149;149;115;116;140;116 08:35:53 INFO - PROCESS | 1924 | |2;audio-dft;195;198;202;199;230;196;191;274;289;193 08:35:53 INFO - PROCESS | 1924 | |3;audio-fft;82;60;59;83;59;61;62;60;79;60 08:35:53 INFO - PROCESS | 1924 | |4;audio-oscillator;91;71;92;72;70;93;121;103;76;88 08:35:53 INFO - PROCESS | 1924 | |5;imaging-gaussian-blur;92;88;91;90;93;106;135;132;130;89 08:35:53 INFO - PROCESS | 1924 | |6;imaging-darkroom;100;97;98;97;123;153;97;108;153;124 08:35:53 INFO - PROCESS | 1924 | |7;imaging-desaturate;118;89;84;137;131;89;95;91;88;88 08:35:53 INFO - PROCESS | 1924 | |8;json-parse-financial;47;49;89;92;92;59;60;61;61;60 08:35:53 INFO - PROCESS | 1924 | |9;json-stringify-tinderbox;69;78;85;78;76;71;73;70;67;71 08:35:53 INFO - PROCESS | 1924 | |10;stanford-crypto-aes;86;84;85;83;88;84;84;89;85;85 08:35:53 INFO - PROCESS | 1924 | |11;stanford-crypto-ccm;142;160;155;135;129;137;166;154;186;153 08:35:53 INFO - PROCESS | 1924 | |12;stanford-crypto-pbkdf2;157;201;226;165;237;196;171;170;179;236 08:35:53 INFO - PROCESS | 1924 | |13;stanford-crypto-sha256-iterative;67;69;68;71;87;70;70;88;89;91 08:35:53 INFO - PROCESS | 1924 | __end_tp_report 08:35:53 INFO - PROCESS | 1924 | __start_cc_report 08:35:53 INFO - PROCESS | 1924 | _x_x_mozilla_cycle_collect,955 08:35:53 INFO - PROCESS | 1924 | __end_cc_report 08:35:53 INFO - PROCESS | 1924 | __startTimestamp1484757353130__endTimestamp 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | ------- Summary: start ------- 08:35:53 INFO - PROCESS | 1924 | Number of tests: 14 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | [#0] ai-astar Cycles:10 Average:117.60 Median:118.00 stddev:1.43 (1.2%) stddev-sans-first:1.39 08:35:53 INFO - PROCESS | 1924 | Values: 116.0 120.0 117.0 118.0 118.0 118.0 117.0 115.0 119.0 118.0 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:146.50 stddev:18.07 (12.3%) stddev-sans-first:15.34 08:35:53 INFO - PROCESS | 1924 | Values: 170.0 145.0 144.0 148.0 149.0 149.0 115.0 116.0 140.0 116.0 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | [#2] audio-dft Cycles:10 Average:216.70 Median:200.50 stddev:36.04 (18.0%) stddev-sans-first:37.36 08:35:53 INFO - PROCESS | 1924 | Values: 195.0 198.0 202.0 199.0 230.0 196.0 191.0 274.0 289.0 193.0 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | [#3] audio-fft Cycles:10 Average:66.50 Median:61.50 stddev:10.32 (16.8%) stddev-sans-first:9.30 08:35:53 INFO - PROCESS | 1924 | Values: 82.0 60.0 59.0 83.0 59.0 61.0 62.0 60.0 79.0 60.0 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:82.00 stddev:16.25 (19.8%) stddev-sans-first:17.19 08:35:53 INFO - PROCESS | 1924 | Values: 91.0 71.0 92.0 72.0 70.0 93.0 121.0 103.0 76.0 88.0 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | [#5] imaging-gaussian-blur Cycles:10 Average:104.60 Median:89.50 stddev:19.81 (22.1%) stddev-sans-first:20.48 08:35:53 INFO - PROCESS | 1924 | Values: 92.0 88.0 91.0 90.0 93.0 106.0 135.0 132.0 130.0 89.0 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | [#6] imaging-darkroom Cycles:10 Average:115.00 Median:125.00 stddev:22.53 (18.0%) stddev-sans-first:23.23 08:35:53 INFO - PROCESS | 1924 | Values: 100.0 97.0 98.0 97.0 123.0 153.0 97.0 108.0 153.0 124.0 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | [#7] imaging-desaturate Cycles:10 Average:101.00 Median:88.50 stddev:19.82 (22.4%) stddev-sans-first:20.05 08:35:53 INFO - PROCESS | 1924 | Values: 118.0 89.0 84.0 137.0 131.0 89.0 95.0 91.0 88.0 88.0 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:61.00 stddev:17.29 (28.4%) stddev-sans-first:16.76 08:35:53 INFO - PROCESS | 1924 | Values: 47.0 49.0 89.0 92.0 92.0 59.0 60.0 61.0 61.0 60.0 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:74.50 stddev:5.43 (7.3%) stddev-sans-first:5.48 08:35:53 INFO - PROCESS | 1924 | Values: 69.0 78.0 85.0 78.0 76.0 71.0 73.0 70.0 67.0 71.0 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.00 stddev:1.89 (2.2%) stddev-sans-first:1.99 08:35:53 INFO - PROCESS | 1924 | Values: 86.0 84.0 85.0 83.0 88.0 84.0 84.0 89.0 85.0 85.0 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | [#11] stanford-crypto-ccm Cycles:10 Average:151.70 Median:154.50 stddev:16.91 (10.9%) stddev-sans-first:17.56 08:35:53 INFO - PROCESS | 1924 | Values: 142.0 160.0 155.0 135.0 129.0 137.0 166.0 154.0 186.0 153.0 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.80 Median:198.50 stddev:30.24 (15.2%) stddev-sans-first:28.99 08:35:53 INFO - PROCESS | 1924 | Values: 157.0 201.0 226.0 165.0 237.0 196.0 171.0 170.0 179.0 236.0 08:35:53 INFO - PROCESS | 1924 | 08:35:53 INFO - PROCESS | 1924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.00 Median:79.00 stddev:10.22 (12.9%) stddev-sans-first:10.18 08:35:53 INFO - PROCESS | 1924 | Values: 67.0 69.0 68.0 71.0 87.0 70.0 70.0 88.0 89.0 91.0 08:35:53 INFO - PROCESS | 1924 | -------- Summary: end -------- 08:35:53 INFO - PROCESS | 1924 | 08:35:54 INFO - TEST-INFO | 1924: exit 0 08:35:54 INFO - TEST-OK | kraken | took 61652ms 08:35:54 INFO - SUITE-END | took 1176s 08:35:54 INFO - Completed test suite (00:19:36) 08:35:54 INFO - javascript benchmark 08:35:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7072.731478005242, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.6355000949893, 3321.9501707474383, 3337.532745415641, 3343.3981883261017, 3366.7306615470757, 5572.86067848304, 5608.0, 5632.0, 5665.206871038058, 5680.233168522248, 5621.7751289948355, 5696.344920334162, 5701.971490142543, 5721.141828725693, 5728.914066289009, 5061.569766569837, 5184.455632158626, 5196.194589838581, 5203.869903252411, 5240.580753539708, 5254.185601231796, 5261.342332208474, 5277.340332458442, 5309.707966061865, 5310.92033619496, 5084.974575127119, 5147.794088236466, 5265.210218467222, 5271.789128434858, 5275.419703832595, 5153.561947234452, 5180.559652429548, 5207.557357624606, 5215.452377500345, 5243.318368612075, 5102.132637451642, 5210.166373380241, 5215.8174463893965, 5274.5780337572905, 5292.073887069748, 5654.688992105433, 5672.546196304285, 5682.602217844753, 5755.798547050875, 5780.16187652788, 5799.971000145015, 5891.351951285355, 5909.734061967179, 5958.702064896738, 5967.254093238345, 6077.848053798646, 6082.635041897456, 6091.51267898567, 6100.938990610126, 6145.723442445101, 5700.087985922274, 5714.057180565202, 5714.942850571524, 5725.942740572541, 5840.182374467578, 6232.532560057924, 6259.405356491126, 6262.248530176408, 6283.8114856554375, 6284.4344009039405, 5908.4091590841435, 5961.940380596226, 6113.5414843886, 6134.079888016833, 6136.048912418582, 6059.909101363483, 6088.665123418166, 6131.286584637414, 6132.877342453126, 6171.043488259327, 4959.975200123977, 6077.027675571887, 6093.11649810775, 6096.573239873255, 6140.723667434976, 5941.881162376728, 6090.969545152246, 6096.451319381188, 6098.786542470993, 6123.877522449615, 4835.734034628129, 4869.245266983552, 4876.536729010738, 4898.975505122523, 4929.827456039022, 4324.243257429937, 4327.0, 4343.67422443318, 4350.2387082260475, 4371.978140109342, 5021.673591216632, 5659.094544872883, 5805.94194058054, 5824.796132135355, 5829.213056237439, 4374.4531933508315, 6114.327782088734, 6133.304060594615, 6163.044728067157, 6221.906671399933, 5008.499150084962, 5639.577031722637, 5704.429557044263, 5708.942910570924, 5731.971340143273, 4612.077584483117, 5205.089109405839, 5264.631475796734, 5312.203169524602, 5348.983693098299, 6214.440700337082, 6239.064140378798, 6248.937510624835, 6249.0626406039455, 6287.779927702509, 6200.914839902909, 6207.255129384503, 6218.5647004711045, 6239.563230573998, 6271.184745982993, 6293.937060629335, 6326.3989920959275, 6331.9366806331345, 6347.619142851444, 6353.36466353361, 5985.910211346921, 6013.9699301503215, 6035.818925432069, 6087.634741915499, 6131.202943617302, 6271.905921411274, 6286.057091436322, 6295.087212354275, 6300.023496357889, 6306.054091886253, 6079.696015199134, 6088.086786981989, 6095.420935011167, 6115.541334399849, 6122.142899993915, 5708.54331653475, 5745.396733342939, 5871.823845284648, 5951.464368206709, 6100.725467353891, 5593.300837395325, 5649.152627105803, 5668.093105103164, 5688.40271771458, 5688.63023903445, 5797.333306669787, 5798.768049277982, 5798.768049277982, 5818.010938140611, 5833.912491312719, 5671.489565939085, 5694.800681976111, 5723.227364305932, 5739.569532285179, 5847.356790753099], "value": 5605.7039529988015, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.8576512811285, 492.54193599952055, 493.48430889720237, 518.1683398145977, 535.2292698514142, 38363.42454863176, 39791.403128953054, 39922.60077399225, 41104.76685699434, 41107.0, 41110.58889411105, 41498.377524337084, 41500.37749433753, 41656.0, 41743.58256417435, 9266.258699304039, 9432.434053956784, 9433.245340372754, 9435.528223588828, 9448.291378146632, 9439.480828554426, 9469.147776700096, 9476.715698529055, 9477.763055923622, 9488.146066853982, 9385.061493850595, 9405.764855878624, 9430.387024843363, 9441.15029647335, 9444.527773611326, 9377.343585948985, 9410.529473526296, 9466.715998520056, 9473.478958657237, 9484.05159484053, 9239.029901860342, 9278.0, 9310.86033709495, 9364.0, 9377.249820014451, 39164.412533812014, 39372.60627393718, 39452.816415507295, 39528.20943581141, 39537.80231098855, 3229.7254733347695, 3242.8864989725485, 3321.6014078310513, 3661.2311414602964, 3809.733318667694, 28569.285767855763, 29020.709792902013, 29269.56095658567, 29786.55320170199, 30082.79668813245, 3100.3489267253904, 3173.3653269346223, 3178.4278829810623, 3184.617845858512, 3204.9359012819846, 461704.0, 462860.0, 468101.0, 468490.6575467101, 468726.0, 58411.0, 58804.0, 58862.0, 58886.527836804424, 58948.11577826336, 62941.68529157416, 62995.05507417392, 63266.0510092349, 63404.0, 63451.68274158692, 15606.765898511305, 15718.0, 16047.759283610756, 16085.0, 16107.597310067107, 10292.433916134534, 12070.758584828254, 12215.633530994084, 12283.69290767738, 12286.385680716106, 17957.0, 18481.260749570134, 18516.0, 18530.16614252362, 18563.72154417685, 7297.051383320135, 7301.707931682779, 7429.6596572079625, 7504.598528470946, 7541.509801862861, 701.340739704676, 806.2018601584389, 851.5231470376609, 971.7667759737753, 990.5393991793707, 25875.48249035009, 27381.26187381246, 28942.565861512096, 29707.108786736433, 29795.85102074519, 974.5760594141572, 1035.7203555040096, 1049.3913530152493, 1058.523664351045, 1120.1934607082887, 14759.376468588447, 14763.114213147246, 14854.331555080047, 14952.626184345478, 15135.697286054437, 643404.7829760822, 651601.0, 654165.0, 655316.0, 657330.0, 54552.45447545553, 54837.725811370685, 54885.725571372684, 54968.45031549713, 55628.0, 1329.7872340425486, 1341.1349679456891, 1349.0354396606474, 1362.7070179911366, 1367.6170672211797, 27305.180844574694, 28166.0, 28439.11470251003, 28655.14034578966, 28805.7119428803, 47420.0, 48219.0, 48229.0, 48266.034679305514, 48367.0, 518113.0, 586284.0, 607233.0, 613082.0, 613776.0, 25742.613860792477, 25983.480330393664, 26808.0, 26883.731162688906, 27606.72393276122, 44674.3298850524, 44919.77540112409, 44947.32579011252, 45637.54362456333, 45662.77168614136, 37029.44455833219, 37107.6289237115, 37847.43228851625, 38157.427638584886, 38802.0, 37445.4383184247, 37564.43653345147, 38260.808695956344, 38646.420303694904, 38715.8385248443, 32900.01299961005, 36414.72548460791, 36736.0, 37152.62847371492, 37231.0, 28618.57072143878, 32462.67537324691, 34036.319273614885, 34104.97685069452, 34256.48615270723, 24951.376215594755, 25224.74775252224, 25449.765220812445, 25508.872455638346, 25565.872170639028], "value": 19485.438195557013, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.6663835951746, 366.1121779684265, 370.792356280483, 375.64126259422255, 391.5849199848161, 17376.391826286083, 17977.640447191065, 18577.442676719686, 18583.25666973323, 19568.608627827434, 15578.532644020697, 18478.353257635987, 19253.133608987595, 19274.229030838786, 19391.612167756673, 5821.0, 6078.817635470943, 6086.665233412183, 6100.054491553817, 6119.5104391648565, 4975.2039673652225, 5662.320521537421, 5993.011153159723, 5998.4001599839885, 6002.819915402523, 5847.5029622481925, 5878.706064696748, 5893.38119497453, 5930.021546444831, 5934.080217566263, 5666.263385759846, 5883.764649414018, 5960.761569537213, 6038.879222415527, 6088.208532890696, 4966.627502937295, 5242.6330156889035, 5850.941490585083, 5863.149843272744, 5886.411358864122, 12464.0, 12536.0, 12669.429875655618, 12719.427625756864, 16539.751903721455, 2234.642457206839, 2265.184533567914, 2408.638704194367, 2661.38788078743, 2799.678037025748, 9535.570899309549, 9784.364016338915, 10052.547635356426, 11742.471588778526, 14954.953153279275, 1419.8012278281049, 1850.9167087481096, 1863.2453856188265, 1868.8785228960073, 1876.2307453943954, 100215.49892250565, 105493.0, 107022.0, 122966.0, 126657.73342266552, 9453.669121580711, 10842.403667798348, 11261.155413343868, 11653.6503904883, 11688.649340519798, 14038.508652197124, 14111.858881411259, 14318.355673994694, 14325.212113333866, 14434.206118663575, 7821.530708157528, 8272.503649781032, 8274.420790544604, 8370.246677799027, 8375.539345336065, 7481.738139165212, 8093.635786389626, 8204.015518137743, 8242.752717418487, 8361.707340243061, 4421.977890110593, 4458.643308535309, 4460.0, 4472.195004899084, 4541.75020373876, 1887.1507821480388, 1934.1876411907033, 1934.7001214811446, 1935.1968932892692, 1946.5133716570858, 820.9220124088203, 847.656699036891, 856.4775486952954, 883.9646414143363, 927.9304052195977, 19707.0, 20710.896445517676, 20762.89618551928, 20894.37316880496, 21201.893990530258, 874.9606267717968, 909.1726528858838, 909.977250568741, 925.6991477769752, 940.4827344960381, 9372.39079459833, 10566.894331056592, 10696.732581685364, 10886.72783180411, 10945.726356841144, 564966.0, 570711.0, 585193.0, 585334.0, 585643.0, 109502.0, 110313.44843275732, 123165.0, 125356.0, 127390.10113880734, 939.4175611121012, 964.2719746591279, 988.560090759605, 992.3004281981185, 995.9103680668775, 18340.81659183391, 18853.528661783566, 19059.523511912314, 19086.904565477085, 19113.044347782834, 55132.0, 55271.72364138153, 55879.44120558743, 56225.43774562202, 57559.71220143873, 69058.30941690519, 74412.62793685996, 75342.86985695109, 76585.61707191428, 78117.0, 7547.433942454448, 7922.0889597694695, 8007.919920800718, 8082.676692932217, 8272.965879265092, 11813.40932953366, 12471.875281247072, 12598.87401125977, 12729.681757956125, 12753.808692869428, 8734.475931444134, 9906.257030722869, 10156.746081348025, 10183.847242291224, 10817.0, 8706.738797836075, 8852.690155844515, 9432.717018489457, 10195.84706229422, 10951.945240273748, 9254.167124958516, 9425.858612120961, 10802.161429254977, 10927.07119894786, 11757.470913808727, 8063.072746634212, 8175.059868115243, 8222.506649601042, 8288.875666865122, 8321.41750077513, 9078.727638170865, 9781.804363912825, 11024.653618643084, 11084.334939903632, 11172.888271117185], "value": 9169.402917140944, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.4575784080969, 1474.5060404764404, 1621.505440840544, 1738.5305967388813, 1768.1601239411289, 6673.599584024962, 7550.0, 7780.377569794417, 8534.573271336432, 8562.015368232647, 7990.280874721274, 8270.421070525066, 8278.503289802617, 8391.412601117909, 8414.116517765638, 2286.88565571722, 2321.8955147018423, 2325.0699720112007, 2325.360525855395, 2334.533093381322, 2320.825938054644, 2342.367560758603, 2343.484433424644, 2355.5995480768224, 2372.632242002484, 2188.9233876814314, 2190.1896298369625, 2205.4155648753094, 2211.6793065005645, 2229.9665505017356, 2254.875981820999, 2265.9773402266014, 2282.4408020035116, 2288.3821368230483, 2290.4273931517123, 1938.4766113149512, 2310.2260742651233, 2319.9072037118663, 2348.236823032504, 2350.8589484630975, 8305.584720763938, 8368.832623347498, 8420.326373890073, 8427.367947403969, 8453.323734101257, 5073.923891141636, 5221.530062294411, 5228.0, 5245.291885595434, 5247.344081989751, 3223.9677603223904, 3226.806391616487, 3292.9506057409158, 3483.2583708145926, 3550.0592343029116, 1035.761774791802, 1054.0618849224197, 1058.8623478947688, 1063.7234319077018, 1097.1661537231682, 10760.56957721698, 10784.191185661028, 10796.784064318748, 10882.183836212236, 10893.019628233496, 3946.743461674982, 4518.457785065747, 4612.962083531179, 4768.451628062817, 4775.116603428308, 9333.346665733334, 9417.811643767087, 9429.198518126037, 9433.90566094344, 9451.29115316354, 5173.586113110942, 5176.249443830623, 5193.091209038404, 5202.115640341151, 5211.374635043819, 4245.830166793356, 4300.301740503165, 4677.087967846237, 4742.312364707167, 4751.121042607128, 3421.8802341918413, 3776.244751049746, 3821.9617803821607, 3857.4406711026745, 3924.2543916656314, 1262.501311981762, 1272.2175861845083, 1273.4587800184884, 1279.7632437999, 1292.7349893271858, 754.5925200391727, 854.1757204297758, 895.8790563274005, 898.1243287794348, 912.3476714149282, 4764.380630518011, 5636.351819540723, 5809.24479817621, 5835.503982161564, 5872.067463330823, 841.3731769831514, 920.2086205862953, 929.9767505812409, 944.527736131934, 955.3169483819103, 3576.5886923004186, 3713.9071523212137, 3759.962400376016, 3792.6776224020714, 3805.086779173034, 8464.365172611955, 9812.705618831447, 10024.649137280307, 10149.137323327452, 10170.644027459004, 8399.454035487674, 10034.0, 10077.798444031077, 10085.041921017491, 10110.988901109977, 7507.1366792818435, 7708.807279818049, 7828.2954534092205, 7874.173211812792, 7986.560739159286, 5712.171735098471, 5732.828015159552, 5843.094320380348, 5882.735276912635, 5990.430909063632, 8128.9593552031865, 9244.676436324697, 9289.256859451092, 9414.62341506332, 9442.48066356357, 9053.004169541477, 9381.859272110787, 9445.102715242041, 9484.0, 9512.1439070484, 6649.268580456049, 6708.731650733916, 6830.077939478107, 6841.521093523605, 6954.756583519553, 7744.961275193813, 7978.321842643209, 7987.361011119213, 7998.520088794691, 8000.599970001593, 6024.548158888013, 6031.638101713911, 7170.9960605514225, 7197.82005449847, 7239.4932354734665, 6085.752420753646, 6833.829154271183, 6970.059042029261, 7056.894146587702, 7097.858042839011, 5729.197912292366, 6511.544191906711, 6633.402993730588, 6691.966540167268, 6717.05961165447, 4717.905641887074, 4744.667873248977, 4770.666053376231, 4793.760311984456, 4838.588719958843, 4762.785674644719, 4793.544613261734, 4803.279508073817, 4872.317875497362, 4887.0], "value": 4372.259257346672, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.58948871437207, 299.186213499282, 308.134143058007, 309.3272133110484, 311.49071268476035, 4957.454679985199, 5008.724520151395, 5268.89135410108, 5400.324959380077, 5493.901219756055, 5273.446288139748, 5403.297571315733, 5442.346918369792, 5456.699881506515, 5496.780128794843, 3754.3992961126223, 4094.4472496213075, 4167.4790651168605, 4169.270377683908, 4182.477190351206, 3352.9497057544036, 4079.938800917989, 4121.629053385194, 4167.937480937789, 4193.993441574031, 3411.317736452707, 3619.239959608485, 4119.196756632457, 4128.1330920506725, 4136.482939632546, 3775.716256472785, 4121.5466298707115, 4132.979335103335, 4152.875413737593, 4172.853950111731, 3462.3248466549035, 3630.3102410541915, 3634.60019397866, 3656.4149736042104, 3657.104009517685, 4793.304970779218, 4956.801727930879, 5359.461457022466, 5361.0618141825025, 5383.757730902119, 3696.1868388954385, 3962.841486340543, 4127.7936103194725, 4606.894345357124, 4726.998356043902, 5723.0, 5737.254156959611, 5741.511971482429, 5742.483176514092, 5807.680577568232, 3386.9661303386897, 3552.431610942237, 3712.576639754573, 3885.9611403885883, 3922.2155568886337, 5185.844424667266, 6039.520317522235, 6072.483838873701, 6075.574709770318, 6171.59884607499, 3317.983410082934, 3955.9121241658772, 3959.7030222732833, 3975.20495900821, 3989.84040638377, 3196.856141473639, 3955.20895820837, 3977.6817854571564, 4003.8798836034966, 4015.3976903464713, 4153.68847336451, 4628.699134556243, 4641.9555599989735, 4642.767861606973, 4671.416072990876, 5158.123119069767, 5793.362730099686, 5813.883722325614, 5850.473457388855, 5862.856742935087, 1162.7733040811815, 1220.9621821451694, 1257.8239046533492, 1258.7671280813079, 1274.1463219642862, 678.8811957907346, 782.1787123520281, 860.5568132411813, 862.4868203418956, 885.106042896679, 4431.689781715249, 4635.519996801695, 4923.606111511142, 5075.492450754895, 5121.231815227671, 5369.060414427459, 5478.192196575121, 5598.272224610774, 5653.236813030188, 5707.343655479673, 4624.86690760759, 4879.463259041502, 5129.589632829365, 5138.511841375063, 5143.3570803649545, 2441.694788151481, 2730.447032025063, 2856.757175640052, 2883.408901175254, 2965.481040817848, 4810.8797280068275, 4858.78135483904, 5842.298924129047, 5860.560457965669, 5865.706714664249, 4511.796969136397, 4943.5797957174045, 5498.532624726863, 5691.430856914276, 5776.68228247442, 5044.713598032478, 5114.488551145005, 5710.086386178275, 5743.913841292384, 5784.223572685219, 4319.719218250803, 4476.731396116244, 5135.87160320995, 5184.96300739846, 5631.408702086222, 4528.6377089833395, 5191.158542678466, 5393.97514472249, 5482.835514934558, 5533.889322213453, 4845.200541910545, 4978.8755281118265, 5064.265681476239, 5146.716930568855, 5535.944640553704, 3294.8517316720327, 3665.633436656313, 3725.720570957243, 3741.9064523387133, 3748.7001039917286, 5198.818041368534, 5497.8075767347955, 5554.972539965809, 5574.247476590608, 5630.507915402503, 5358.705271210121, 5553.416891226363, 5651.237082993744, 5729.455701708331, 5831.912521312099, 4646.558576935186, 5054.646174767878, 5762.328924611816, 5818.76724930998, 5857.619254748598, 4467.441569803775, 5374.193870919394, 5614.63504872182, 5690.260266165372, 5695.971520142372, 5675.602707810579, 5747.396523365153, 5764.385971927867, 5769.798057067983, 5787.536997040311, 5655.501292157664, 5665.943340566707, 5696.515796157373, 5715.742791574306, 5717.571182161271], "value": 4042.133567693353, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.1321788284172, 674.6795272245687, 682.7061074788709, 739.3124394313287, 743.8549482850844, 13886.097403668768, 14812.11127332358, 14814.925925370386, 14827.77758333626, 14837.554873353789, 10906.61826836061, 13232.33838308083, 13333.666658333523, 13351.399187036583, 13357.398917048731, 623.3392603839922, 647.685872351909, 773.717593078525, 790.5849429049738, 806.3629732511309, 808.4906508899414, 808.8220591469897, 810.1817164663703, 810.5541951926447, 810.8702607582788, 849.6134258912211, 850.2093053460279, 854.679495189304, 855.9229669329759, 856.6316483911916, 839.1063517354029, 845.8477474054637, 846.9237768600856, 847.7541512961265, 849.2950850793826, 622.4895585619794, 628.6605233174126, 632.0708558419117, 635.891898377277, 637.3148864970176, 13555.45778168882, 13876.58370248894, 13903.79144312826, 13916.860831391657, 14272.571822845332, 11212.775744485065, 13364.131331463424, 13536.390862411117, 14006.789898151535, 14022.158670479805, 10490.58037678492, 10931.125509959184, 11178.44107794607, 11210.159238057096, 11467.713307167303, 4319.654427645781, 4335.5014173370155, 4380.167768124046, 4421.135623075713, 4425.778711064434, 84212.3157536852, 86556.0, 86723.56638216769, 87942.12057879403, 89413.55293223557, 9947.154491868272, 10164.695059148238, 10169.593216271414, 10192.439415832201, 10204.336718113298, 18817.341393051178, 18968.0, 18984.14571344293, 19093.0, 19130.330438434587, 6926.930730692729, 7148.749793757193, 7287.744928927462, 7324.08448943882, 7446.180920098785, 3447.9655203447646, 3744.251149770057, 3750.8124593770203, 4192.161567686475, 4265.91468170641, 3278.770461077096, 3527.6825085742407, 3696.2607478504406, 3699.926001479955, 3732.738708290394, 554.2822045451151, 661.685699292832, 685.0683071023404, 694.2883544367064, 697.6790676288964, 561.3123923194137, 569.4133752622664, 624.8843963866699, 646.5991085527004, 662.8972509261072, 7705.075390953121, 7741.458097933203, 8556.224548429786, 9140.54297285133, 9250.398724082914, 558.4861927027144, 596.6151832068379, 606.836154238362, 617.4813156948185, 643.9195100612424, 4290.957090429119, 4476.910461790746, 4479.260921947907, 4483.036147228297, 4498.527654596221, 51426.74286628543, 68941.96587051198, 69783.65108174528, 78672.0, 100609.0, 74276.62861685765, 77822.2217777815, 78913.25499588378, 93178.0, 97321.51339243258, 59795.0, 79822.20177798264, 86293.0, 86519.0, 86706.1329386698, 9396.107369799858, 9637.662681806103, 9698.46658433793, 9763.316567840184, 9769.120779129627, 54227.72886135544, 54250.0, 54488.72755636196, 54949.17576236439, 55614.44385556092, 49278.260826086924, 49863.0, 54050.72974635102, 75863.0, 78412.0, 12471.069833827869, 12509.186902851285, 12519.248845069325, 12553.995680345733, 12849.743005140032, 13723.862761372258, 13724.862751372359, 13886.236257005961, 14133.293335333397, 14329.068610540282, 12816.487340506275, 12861.2926289055, 13060.21638701681, 13141.934290328487, 13176.868231317565, 12498.750024999266, 12576.182548134342, 12651.493940242288, 13065.0, 13236.801447978096, 12479.56321528742, 12672.239665620093, 12785.424655890693, 13010.414531346301, 13257.867421325664, 10803.945980270048, 11024.062954648945, 11370.431478426211, 11431.314121152758, 11520.251183673034, 11167.49746261404, 11223.214374993671, 11397.715057123638, 11415.315081094828, 11422.94288528552], "value": 7070.956796807298, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1596.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 120.0, 117.0, 118.0, 118.0, 118.0, 117.0, 115.0, 119.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 145.0, 144.0, 148.0, 149.0, 149.0, 115.0, 116.0, 140.0, 116.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 198.0, 202.0, 199.0, 230.0, 196.0, 191.0, 274.0, 289.0, 193.0], "value": 216.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 59.0, 83.0, 59.0, 61.0, 62.0, 60.0, 79.0, 60.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 92.0, 72.0, 70.0, 93.0, 121.0, 103.0, 76.0, 88.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 91.0, 90.0, 93.0, 106.0, 135.0, 132.0, 130.0, 89.0], "value": 104.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 97.0, 98.0, 97.0, 123.0, 153.0, 97.0, 108.0, 153.0, 124.0], "value": 115.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 89.0, 84.0, 137.0, 131.0, 89.0, 95.0, 91.0, 88.0, 88.0], "value": 101.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 49.0, 89.0, 92.0, 92.0, 59.0, 60.0, 61.0, 61.0, 60.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 78.0, 85.0, 78.0, 76.0, 71.0, 73.0, 70.0, 67.0, 71.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 83.0, 88.0, 84.0, 84.0, 89.0, 85.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 160.0, 155.0, 135.0, 129.0, 137.0, 166.0, 154.0, 186.0, 153.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 201.0, 226.0, 165.0, 237.0, 196.0, 171.0, 170.0, 179.0, 236.0], "value": 193.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 71.0, 87.0, 70.0, 70.0, 88.0, 89.0, 91.0], "value": 77.0, "unit": "score"}]}]} 08:35:54 INFO - Return code: 0 08:35:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:35:54 ERROR - # TBPL SUCCESS # 08:35:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:35:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:35:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:35:54 INFO - 2017-01-18 08:35:54.401 screenresolution[1929:23794] starting screenresolution argv=screenresolution get 08:35:54 INFO - 2017-01-18 08:35:54.403 screenresolution[1929:23794] Display 0: 1600x1200x32@60 08:35:54 INFO - 2017-01-18 08:35:54.410 screenresolution[1930:23797] starting screenresolution argv=screenresolution list 08:35:54 INFO - Available Modes on Display 0 08:35:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:35:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:35:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:35:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:35:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:35:54 INFO - Intel Iris: 08:35:54 INFO - Chipset Model: Intel Iris 08:35:54 INFO - Type: GPU 08:35:54 INFO - Bus: Built-In 08:35:54 INFO - VRAM (Dynamic, Max): 1536 MB 08:35:54 INFO - Vendor: Intel (0x8086) 08:35:54 INFO - Device ID: 0x0a2e 08:35:54 INFO - Revision ID: 0x0009 08:35:54 INFO - Displays: 08:35:54 INFO - Display: 08:35:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:35:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:35:54 INFO - Display Serial Number: 1600x1200 60 08:35:54 INFO - Main Display: Yes 08:35:54 INFO - Mirror: Off 08:35:54 INFO - Online: Yes 08:35:54 INFO - Rotation: Supported 08:35:54 INFO - Return code: 0 08:35:54 INFO - Running post-action listener: _resource_record_post_action 08:35:54 INFO - [mozharness: 2017-01-18 16:35:54.654801Z] Finished run-tests step (success) 08:35:54 INFO - Running post-run listener: _resource_record_post_run 08:35:54 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 770048; Write bytes: 655178752; Read time: 10; Write time: 1901 08:35:54 INFO - TinderboxPrint: CPU usage
54.3% 08:35:54 INFO - TinderboxPrint: I/O read bytes / time
770,048 / 10 08:35:54 INFO - TinderboxPrint: I/O write bytes / time
655,178,752 / 1,901 08:35:54 INFO - TinderboxPrint: CPU idle
2,208.0 (45.7%) 08:35:54 INFO - TinderboxPrint: CPU system
977.7 (20.2%) 08:35:54 INFO - TinderboxPrint: CPU user
1,648.0 (34.1%) 08:35:54 INFO - TinderboxPrint: Swap in / out
349,720,576 / 0 08:35:54 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 338737664; Write bytes: 335296512; Read time: 26882; Write time: 710 08:35:54 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 770048; Write bytes: 302158848; Read time: 10; Write time: 1135 08:35:55 INFO - Running post-run listener: _upload_blobber_files 08:35:55 INFO - Blob upload gear active. 08:35:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:35:55 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 08:35:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:35:55 INFO - (blobuploader) - INFO - Open directory for files ... 08:35:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:35:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:35:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:56 INFO - (blobuploader) - INFO - Done attempting. 08:35:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:35:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:35:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:58 INFO - (blobuploader) - INFO - Done attempting. 08:35:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:35:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:00 INFO - (blobuploader) - INFO - Done attempting. 08:36:00 INFO - (blobuploader) - INFO - Iteration through files over. 08:36:00 INFO - Return code: 0 08:36:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:36:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:36:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fa5e37eabb7a881aad7fdf5f528ab681b511a06eda7263238ed393972509b7a8061945ca2f0b78db7b0aaffb8a1ce4852abc181580afc99d592244123552b91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39696b2738eae82e7f173ffefc6a41a83d460b9b2b78d24d2ef05c521592ea8aa161aec2631fb45eae7ac09b03a2d60558c668ddfb930bfad089b2d0ed7be5ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c738a7187b39386d98df5357e622aad01f166c5f5857238839754b53e3fb2de392975e30f0d2e00ba0105493f17488f612c8e1e98ab8ae248c35ba2997488856"} 08:36:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:36:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:36:00 INFO - Contents: 08:36:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fa5e37eabb7a881aad7fdf5f528ab681b511a06eda7263238ed393972509b7a8061945ca2f0b78db7b0aaffb8a1ce4852abc181580afc99d592244123552b91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39696b2738eae82e7f173ffefc6a41a83d460b9b2b78d24d2ef05c521592ea8aa161aec2631fb45eae7ac09b03a2d60558c668ddfb930bfad089b2d0ed7be5ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c738a7187b39386d98df5357e622aad01f166c5f5857238839754b53e3fb2de392975e30f0d2e00ba0105493f17488f612c8e1e98ab8ae248c35ba2997488856"} 08:36:00 INFO - Running post-run listener: copy_logs_to_upload_dir 08:36:00 INFO - Copying logs to upload dir... 08:36:00 INFO - mkdir: /builds/slave/test/build/upload/logs 08:36:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.233881 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-01-18 08:36:00.362805) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 08:36:00.363429) ========= 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.4UsUtRNOWB/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.obsuLi75vm/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fa5e37eabb7a881aad7fdf5f528ab681b511a06eda7263238ed393972509b7a8061945ca2f0b78db7b0aaffb8a1ce4852abc181580afc99d592244123552b91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39696b2738eae82e7f173ffefc6a41a83d460b9b2b78d24d2ef05c521592ea8aa161aec2631fb45eae7ac09b03a2d60558c668ddfb930bfad089b2d0ed7be5ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c738a7187b39386d98df5357e622aad01f166c5f5857238839754b53e3fb2de392975e30f0d2e00ba0105493f17488f612c8e1e98ab8ae248c35ba2997488856"} build_url:https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/UnFyo2-QSUWPiL3jI3Z7ag/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fa5e37eabb7a881aad7fdf5f528ab681b511a06eda7263238ed393972509b7a8061945ca2f0b78db7b0aaffb8a1ce4852abc181580afc99d592244123552b91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39696b2738eae82e7f173ffefc6a41a83d460b9b2b78d24d2ef05c521592ea8aa161aec2631fb45eae7ac09b03a2d60558c668ddfb930bfad089b2d0ed7be5ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c738a7187b39386d98df5357e622aad01f166c5f5857238839754b53e3fb2de392975e30f0d2e00ba0105493f17488f612c8e1e98ab8ae248c35ba2997488856"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 08:36:00.405340) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:36:00.405646) ========= 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.4UsUtRNOWB/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.obsuLi75vm/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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.004978 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:36:00.453986) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 08:36:00.454255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 08:36:00.454567) ========= ========= Total master_lag: 1.24 =========