builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0289 starttime: 1470616843.63 results: success (0) buildid: 20160807150152 builduid: fa817272ff634ddb9b55e52d06355727 revision: ad2be3aadc626da670b5d0dd60e19afe2108b25b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 17:40:43.627437) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 17:40:43.629764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 17:40:43.630050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 17:40:43.850770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 17:40:43.851061) ========= 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.iv0lE1QZz8/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.YYan4fEvJP/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-07 17:40:43-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.2M=0.001s 2016-08-07 17:40:44 (19.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.650920 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 17:40:44.541440) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 17:40:44.541821) ========= 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.iv0lE1QZz8/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.YYan4fEvJP/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.032416 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 17:40:44.596680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 17:40:44.597135) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ad2be3aadc626da670b5d0dd60e19afe2108b25b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ad2be3aadc626da670b5d0dd60e19afe2108b25b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iv0lE1QZz8/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.YYan4fEvJP/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-07 17:40:44,677 truncating revision to first 12 chars 2016-08-07 17:40:44,678 Setting DEBUG logging. 2016-08-07 17:40:44,678 attempt 1/10 2016-08-07 17:40:44,678 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ad2be3aadc62?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 17:40:45,390 unpacking tar archive at: mozilla-central-ad2be3aadc62/testing/mozharness/ program finished with exit code 0 elapsedTime=1.001740 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 17:40:45.620905) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 17:40:45.621220) ========= script_repo_revision: ad2be3aadc626da670b5d0dd60e19afe2108b25b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 17:40:45.621623) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 17:40:45.621892) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 17:40:45.641352) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-07 17:40:45.641781) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iv0lE1QZz8/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.YYan4fEvJP/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:40:45 INFO - MultiFileLogger online at 20160807 17:40:45 in /builds/slave/test 17:40:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:40:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:40:45 INFO - {'append_to_log': False, 17:40:45 INFO - 'base_work_dir': '/builds/slave/test', 17:40:45 INFO - 'blob_upload_branch': 'Firefox', 17:40:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:40:45 INFO - 'branch': 'Firefox', 17:40:45 INFO - 'buildbot_json_path': 'buildprops.json', 17:40:45 INFO - 'config_files': ('talos/mac_config.py',), 17:40:45 INFO - 'default_actions': ('clobber', 17:40:45 INFO - 'read-buildbot-config', 17:40:45 INFO - 'download-and-extract', 17:40:45 INFO - 'populate-webroot', 17:40:45 INFO - 'create-virtualenv', 17:40:45 INFO - 'install', 17:40:45 INFO - 'run-tests'), 17:40:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:40:45 INFO - 'download_minidump_stackwalk': True, 17:40:45 INFO - 'download_symbols': 'ondemand', 17:40:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:40:45 INFO - 'tooltool.py': '/tools/tooltool.py', 17:40:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:40:45 INFO - '/tools/misc-python/virtualenv.py')}, 17:40:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:40:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:40:45 INFO - 'installer_path': 'installer.exe', 17:40:45 INFO - 'log_level': 'info', 17:40:45 INFO - 'log_name': 'talos', 17:40:45 INFO - 'log_to_console': True, 17:40:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:40:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:40:45 INFO - 'opt_config_files': (), 17:40:45 INFO - 'pip_index': False, 17:40:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:40:45 INFO - 'cmd': ('bash', 17:40:45 INFO - '-c', 17:40:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:40:45 INFO - 'enabled': True, 17:40:45 INFO - 'halt_on_failure': False, 17:40:45 INFO - 'name': 'check_screen_resolution'},), 17:40:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:40:45 INFO - 'cmd': ('bash', 17:40:45 INFO - '-c', 17:40:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:40:45 INFO - 'enabled': True, 17:40:45 INFO - 'halt_on_failure': False, 17:40:45 INFO - 'name': 'check_screen_resolution'},), 17:40:45 INFO - 'run_cmd_checks_enabled': True, 17:40:45 INFO - 'sps_profile': False, 17:40:45 INFO - 'sps_profile_interval': 0, 17:40:45 INFO - 'suite': 'dromaeojs-e10s', 17:40:45 INFO - 'system_bits': '32', 17:40:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:40:45 INFO - 'title': 't-yosemite-r7-0289', 17:40:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:40:45 INFO - 'use_talos_json': True, 17:40:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:40:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:40:45 INFO - 'work_dir': 'build'} 17:40:45 INFO - [mozharness: 2016-08-08 00:40:45.842935Z] Running clobber step. 17:40:45 INFO - Running pre-action listener: _resource_record_pre_action 17:40:45 INFO - Running main action method: clobber 17:40:45 INFO - rmtree: /builds/slave/test/build 17:40:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:40:48 INFO - Running post-action listener: _resource_record_post_action 17:40:48 INFO - [mozharness: 2016-08-08 00:40:48.329926Z] Finished clobber step (success) 17:40:48 INFO - [mozharness: 2016-08-08 00:40:48.330052Z] Running read-buildbot-config step. 17:40:48 INFO - Running pre-action listener: _resource_record_pre_action 17:40:48 INFO - Running main action method: read_buildbot_config 17:40:48 INFO - Using buildbot properties: 17:40:48 INFO - { 17:40:48 INFO - "project": "", 17:40:48 INFO - "product": "firefox", 17:40:48 INFO - "script_repo_revision": "production", 17:40:48 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:40:48 INFO - "repository": "", 17:40:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:40:48 INFO - "buildid": "20160807150152", 17:40:48 INFO - "pgo_build": "False", 17:40:48 INFO - "basedir": "/builds/slave/test", 17:40:48 INFO - "buildnumber": 31, 17:40:48 INFO - "slavename": "t-yosemite-r7-0289", 17:40:48 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:40:48 INFO - "platform": "yosemite_r7", 17:40:48 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:40:48 INFO - "branch": "mozilla-central", 17:40:48 INFO - "repo_path": "mozilla-central", 17:40:48 INFO - "revision": "ad2be3aadc626da670b5d0dd60e19afe2108b25b", 17:40:48 INFO - "stage_platform": "macosx64", 17:40:48 INFO - "builduid": "fa817272ff634ddb9b55e52d06355727", 17:40:48 INFO - "slavebuilddir": "test" 17:40:48 INFO - } 17:40:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 17:40:48 INFO - Running post-action listener: _resource_record_post_action 17:40:48 INFO - [mozharness: 2016-08-08 00:40:48.333492Z] Finished read-buildbot-config step (success) 17:40:48 INFO - [mozharness: 2016-08-08 00:40:48.333632Z] Running download-and-extract step. 17:40:48 INFO - Running pre-action listener: _resource_record_pre_action 17:40:48 INFO - Running main action method: download_and_extract 17:40:48 INFO - mkdir: /builds/slave/test/build/tests 17:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:48 INFO - trying https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 17:40:48 INFO - Downloading https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:40:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 17:40:49 INFO - Downloaded 1199 bytes. 17:40:49 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:40:49 INFO - Using the following test package requirements: 17:40:49 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:40:49 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:40:49 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 17:40:49 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:40:49 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 17:40:49 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:40:49 INFO - u'jsshell-mac.zip'], 17:40:49 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:40:49 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 17:40:49 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:40:49 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:40:49 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 17:40:49 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:40:49 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 17:40:49 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:40:49 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 17:40:49 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:40:49 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 17:40:49 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:49 INFO - trying https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:40:49 INFO - Downloading https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:40:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:40:50 INFO - Downloaded 16324246 bytes. 17:40:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:40:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:40:53 INFO - Return code: 0 17:40:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:53 INFO - trying https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:40:53 INFO - Downloading https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:40:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:40:54 INFO - Downloaded 16324246 bytes. 17:40:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:40:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:40:58 INFO - Return code: 0 17:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:58 INFO - trying https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:40:58 INFO - Downloading https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:40:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:40:59 INFO - Downloaded 14413723 bytes. 17:40:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:40:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:40:59 INFO - Return code: 0 17:40:59 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')]} 17:40:59 INFO - trying https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:40:59 INFO - Downloading https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 17:40:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 17:41:03 INFO - Downloaded 111884822 bytes. 17:41:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:41:03 INFO - mkdir: /builds/slave/test/properties 17:41:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:41:03 INFO - Writing to file /builds/slave/test/properties/build_url 17:41:03 INFO - Contents: 17:41:03 INFO - build_url:https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:41:03 INFO - Running post-action listener: _resource_record_post_action 17:41:03 INFO - Running post-action listener: set_extra_try_arguments 17:41:03 INFO - [mozharness: 2016-08-08 00:41:03.727054Z] Finished download-and-extract step (success) 17:41:03 INFO - [mozharness: 2016-08-08 00:41:03.727226Z] Running populate-webroot step. 17:41:03 INFO - Running pre-action listener: _resource_record_pre_action 17:41:03 INFO - Running main action method: populate_webroot 17:41:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:41:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:41:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:41:03 INFO - '--tppagecycles', 17:41:03 INFO - '7'], 17:41:03 INFO - 'tests': ['tsvgm']}}, 17:41:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:41:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:41:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:41:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:41:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:41:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:41:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:03 INFO - 'talos_options': ['--disable-e10s'], 17:41:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:41:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:41:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:03 INFO - 'talos_options': ['--disable-e10s'], 17:41:03 INFO - 'tests': ['damp', 'tps']}, 17:41:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:03 INFO - 'tests': ['damp', 'tps']}, 17:41:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:41:03 INFO - 'tests': ['dromaeo_dom']}, 17:41:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:41:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:41:03 INFO - 'tests': ['basic_compositor_video']}, 17:41:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:41:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:41:03 INFO - 'tests': ['a11yr', 17:41:03 INFO - 'ts_paint', 17:41:03 INFO - 'tpaint', 17:41:03 INFO - 'sessionrestore', 17:41:03 INFO - 'sessionrestore_no_auto_restore', 17:41:03 INFO - 'tabpaint']}, 17:41:03 INFO - 'other-e10s': {'tests': ['a11yr', 17:41:03 INFO - 'ts_paint', 17:41:03 INFO - 'tpaint', 17:41:03 INFO - 'sessionrestore', 17:41:03 INFO - 'sessionrestore_no_auto_restore', 17:41:03 INFO - 'tabpaint']}, 17:41:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:41:03 INFO - 'ts_paint', 17:41:03 INFO - 'tpaint', 17:41:03 INFO - 'sessionrestore', 17:41:03 INFO - 'sessionrestore_no_auto_restore', 17:41:03 INFO - 'tabpaint']}, 17:41:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:41:03 INFO - 'ts_paint', 17:41:03 INFO - 'tpaint', 17:41:03 INFO - 'sessionrestore', 17:41:03 INFO - 'sessionrestore_no_auto_restore', 17:41:03 INFO - 'tabpaint']}, 17:41:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:41:03 INFO - 'tests': ['a11yr', 17:41:03 INFO - 'ts_paint', 17:41:03 INFO - 'tpaint', 17:41:03 INFO - 'sessionrestore', 17:41:03 INFO - 'sessionrestore_no_auto_restore', 17:41:03 INFO - 'tabpaint']}, 17:41:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:41:03 INFO - 'tests': ['a11yr', 17:41:03 INFO - 'ts_paint', 17:41:03 INFO - 'tpaint', 17:41:03 INFO - 'sessionrestore', 17:41:03 INFO - 'sessionrestore_no_auto_restore', 17:41:03 INFO - 'tabpaint']}, 17:41:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:41:03 INFO - 'tests': ['tsvgx', 17:41:03 INFO - 'tsvgr_opacity', 17:41:03 INFO - 'tart', 17:41:03 INFO - 'tscrollx', 17:41:03 INFO - 'cart']}, 17:41:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:41:03 INFO - 'tsvgr_opacity', 17:41:03 INFO - 'tart', 17:41:03 INFO - 'tscrollx', 17:41:03 INFO - 'cart']}, 17:41:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:03 INFO - 'talos_options': ['--disable-e10s'], 17:41:03 INFO - 'tests': ['tp5o']}, 17:41:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:03 INFO - 'tests': ['tp5o']}, 17:41:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:03 INFO - 'talos_options': ['--disable-e10s', 17:41:03 INFO - '--xperf_path', 17:41:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:41:03 INFO - 'tests': ['tp5n']}, 17:41:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:03 INFO - 'talos_options': ['--xperf_path', 17:41:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:41:03 INFO - 'tests': ['tp5n']}}, 17:41:03 INFO - 'talos.zip': {'path': '', 17:41:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:41:03 INFO - Running post-action listener: _resource_record_post_action 17:41:03 INFO - [mozharness: 2016-08-08 00:41:03.746307Z] Finished populate-webroot step (success) 17:41:03 INFO - [mozharness: 2016-08-08 00:41:03.746442Z] Running create-virtualenv step. 17:41:03 INFO - Running pre-action listener: _resource_record_pre_action 17:41:03 INFO - Running main action method: create_virtualenv 17:41:03 INFO - Creating virtualenv /builds/slave/test/build/venv 17:41:03 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 17:41:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:41:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:41:03 INFO - Using real prefix '/tools/python27' 17:41:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:41:04 INFO - Installing distribute.............................................................................................................................................................................................done. 17:41:07 INFO - Installing pip.................done. 17:41:07 INFO - Return code: 0 17:41:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:07 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 0x10808fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108124618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae3a490e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ff3d30>, '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 0x107d58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107febb20>, '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.iv0lE1QZz8/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.YYan4fEvJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:41:07 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 17:41:07 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 17:41:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv0lE1QZz8/Render', 17:41:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:07 INFO - 'HOME': '/Users/cltbld', 17:41:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:07 INFO - 'LOGNAME': 'cltbld', 17:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:07 INFO - 'MOZ_NO_REMOTE': '1', 17:41:07 INFO - 'NO_EM_RESTART': '1', 17:41:07 INFO - 'PAGER': '/bin/cat', 17:41:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:07 INFO - 'PWD': '/builds/slave/test', 17:41:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:07 INFO - 'SHELL': '/bin/bash', 17:41:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYan4fEvJP/Listeners', 17:41:07 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:41:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:07 INFO - 'USER': 'cltbld', 17:41:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:07 INFO - 'XPC_FLAGS': '0x0', 17:41:07 INFO - 'XPC_SERVICE_NAME': '0', 17:41:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:07 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 17:41:07 INFO - Cleaning up... 17:41:07 INFO - Return code: 0 17:41:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:07 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 0x10808fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108124618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae3a490e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ff3d30>, '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 0x107d58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107febb20>, '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.iv0lE1QZz8/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.YYan4fEvJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:41:07 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 17:41:07 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 17:41:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv0lE1QZz8/Render', 17:41:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:07 INFO - 'HOME': '/Users/cltbld', 17:41:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:07 INFO - 'LOGNAME': 'cltbld', 17:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:07 INFO - 'MOZ_NO_REMOTE': '1', 17:41:07 INFO - 'NO_EM_RESTART': '1', 17:41:07 INFO - 'PAGER': '/bin/cat', 17:41:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:07 INFO - 'PWD': '/builds/slave/test', 17:41:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:07 INFO - 'SHELL': '/bin/bash', 17:41:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYan4fEvJP/Listeners', 17:41:07 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:41:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:07 INFO - 'USER': 'cltbld', 17:41:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:07 INFO - 'XPC_FLAGS': '0x0', 17:41:07 INFO - 'XPC_SERVICE_NAME': '0', 17:41:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:08 INFO - Downloading/unpacking psutil>=3.1.1 17:41:08 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 17:41:08 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 17:41:08 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 17:41:08 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 17:41:08 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 17:41:08 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 17:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:41:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:11 INFO - Installing collected packages: psutil 17:41:11 INFO - Running setup.py install for psutil 17:41:11 INFO - building 'psutil._psutil_osx' extension 17:41:11 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 17:41:12 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 17:41:12 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 17:41:12 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 17:41:12 INFO - building 'psutil._psutil_posix' extension 17:41:12 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 17:41:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:41:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:41:12 INFO - ^ 17:41:12 INFO - 1 warning generated. 17:41:12 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 17:41:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:12 INFO - Successfully installed psutil 17:41:12 INFO - Cleaning up... 17:41:12 INFO - Return code: 0 17:41:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:41:12 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')]} 17:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:12 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')]} 17:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:12 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 0x10808fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108124618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae3a490e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ff3d30>, '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 0x107d58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107febb20>, '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.iv0lE1QZz8/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.YYan4fEvJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:41:12 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 17:41:12 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 17:41:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv0lE1QZz8/Render', 17:41:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:12 INFO - 'HOME': '/Users/cltbld', 17:41:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:12 INFO - 'LOGNAME': 'cltbld', 17:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:12 INFO - 'MOZ_NO_REMOTE': '1', 17:41:12 INFO - 'NO_EM_RESTART': '1', 17:41:12 INFO - 'PAGER': '/bin/cat', 17:41:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:12 INFO - 'PWD': '/builds/slave/test', 17:41:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:12 INFO - 'SHELL': '/bin/bash', 17:41:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYan4fEvJP/Listeners', 17:41:12 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:41:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:12 INFO - 'USER': 'cltbld', 17:41:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:12 INFO - 'XPC_FLAGS': '0x0', 17:41:12 INFO - 'XPC_SERVICE_NAME': '0', 17:41:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:41:12 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 17:41:12 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 17:41:12 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 17:41:12 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 17:41:12 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 17:41:12 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 17:41:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:41:15 INFO - Installing collected packages: mozsystemmonitor 17:41:15 INFO - Running setup.py install for mozsystemmonitor 17:41:15 INFO - Successfully installed mozsystemmonitor 17:41:15 INFO - Cleaning up... 17:41:15 INFO - Return code: 0 17:41:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:41:15 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')]} 17:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:15 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')]} 17:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:15 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 0x10808fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108124618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae3a490e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ff3d30>, '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 0x107d58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107febb20>, '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.iv0lE1QZz8/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.YYan4fEvJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:41:15 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 17:41:15 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 17:41:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv0lE1QZz8/Render', 17:41:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:15 INFO - 'HOME': '/Users/cltbld', 17:41:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:15 INFO - 'LOGNAME': 'cltbld', 17:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:15 INFO - 'MOZ_NO_REMOTE': '1', 17:41:15 INFO - 'NO_EM_RESTART': '1', 17:41:15 INFO - 'PAGER': '/bin/cat', 17:41:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:15 INFO - 'PWD': '/builds/slave/test', 17:41:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:15 INFO - 'SHELL': '/bin/bash', 17:41:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYan4fEvJP/Listeners', 17:41:15 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:41:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:15 INFO - 'USER': 'cltbld', 17:41:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:15 INFO - 'XPC_FLAGS': '0x0', 17:41:15 INFO - 'XPC_SERVICE_NAME': '0', 17:41:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:15 INFO - Downloading/unpacking jsonschema==2.5.1 17:41:15 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 17:41:15 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 17:41:15 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 17:41:15 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 17:41:15 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 17:41:15 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 17:41:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:41:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:41:18 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 17:41:18 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 17:41:18 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 17:41:18 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 17:41:18 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 17:41:18 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 17:41:18 INFO - Downloading functools32-3.2.3-2.tar.gz 17:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:41:18 INFO - warning: no files found matching '*.txt' 17:41:18 INFO - no previously-included directories found matching 'build' 17:41:18 INFO - no previously-included directories found matching 'dist' 17:41:18 INFO - no previously-included directories found matching '.git*' 17:41:18 INFO - Installing collected packages: jsonschema, functools32 17:41:18 INFO - Running setup.py install for functools32 17:41:18 INFO - warning: no files found matching '*.txt' 17:41:18 INFO - no previously-included directories found matching 'build' 17:41:18 INFO - no previously-included directories found matching 'dist' 17:41:18 INFO - no previously-included directories found matching '.git*' 17:41:18 INFO - Successfully installed jsonschema functools32 17:41:18 INFO - Cleaning up... 17:41:19 INFO - Return code: 0 17:41:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10808fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108124618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae3a490e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ff3d30>, '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 0x107d58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107febb20>, '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.iv0lE1QZz8/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.YYan4fEvJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:41:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:41:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv0lE1QZz8/Render', 17:41:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:19 INFO - 'HOME': '/Users/cltbld', 17:41:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:19 INFO - 'LOGNAME': 'cltbld', 17:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:19 INFO - 'MOZ_NO_REMOTE': '1', 17:41:19 INFO - 'NO_EM_RESTART': '1', 17:41:19 INFO - 'PAGER': '/bin/cat', 17:41:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:19 INFO - 'PWD': '/builds/slave/test', 17:41:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:19 INFO - 'SHELL': '/bin/bash', 17:41:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYan4fEvJP/Listeners', 17:41:19 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:41:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:19 INFO - 'USER': 'cltbld', 17:41:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:19 INFO - 'XPC_FLAGS': '0x0', 17:41:19 INFO - 'XPC_SERVICE_NAME': '0', 17:41:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:41:19 INFO - Cleaning up... 17:41:19 INFO - Return code: 0 17:41:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10808fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108124618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae3a490e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ff3d30>, '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 0x107d58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107febb20>, '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.iv0lE1QZz8/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.YYan4fEvJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:41:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:41:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv0lE1QZz8/Render', 17:41:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:19 INFO - 'HOME': '/Users/cltbld', 17:41:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:19 INFO - 'LOGNAME': 'cltbld', 17:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:19 INFO - 'MOZ_NO_REMOTE': '1', 17:41:19 INFO - 'NO_EM_RESTART': '1', 17:41:19 INFO - 'PAGER': '/bin/cat', 17:41:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:19 INFO - 'PWD': '/builds/slave/test', 17:41:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:19 INFO - 'SHELL': '/bin/bash', 17:41:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYan4fEvJP/Listeners', 17:41:19 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:41:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:19 INFO - 'USER': 'cltbld', 17:41:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:19 INFO - 'XPC_FLAGS': '0x0', 17:41:19 INFO - 'XPC_SERVICE_NAME': '0', 17:41:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:19 INFO - Downloading/unpacking blobuploader==1.2.4 17:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:22 INFO - Downloading blobuploader-1.2.4.tar.gz 17:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:41:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:41:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:23 INFO - Downloading docopt-0.6.1.tar.gz 17:41:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:41:23 INFO - Installing collected packages: blobuploader, requests, docopt 17:41:23 INFO - Running setup.py install for blobuploader 17:41:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:41:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:41:23 INFO - Running setup.py install for requests 17:41:23 INFO - Running setup.py install for docopt 17:41:24 INFO - Successfully installed blobuploader requests docopt 17:41:24 INFO - Cleaning up... 17:41:24 INFO - Return code: 0 17:41:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41: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')]} 17:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41: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')]} 17:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:24 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 0x10808fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108124618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae3a490e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ff3d30>, '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 0x107d58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107febb20>, '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.iv0lE1QZz8/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.YYan4fEvJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:41:24 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 17:41:24 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 17:41:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv0lE1QZz8/Render', 17:41:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:24 INFO - 'HOME': '/Users/cltbld', 17:41:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:24 INFO - 'LOGNAME': 'cltbld', 17:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:24 INFO - 'MOZ_NO_REMOTE': '1', 17:41:24 INFO - 'NO_EM_RESTART': '1', 17:41:24 INFO - 'PAGER': '/bin/cat', 17:41:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:24 INFO - 'PWD': '/builds/slave/test', 17:41:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:24 INFO - 'SHELL': '/bin/bash', 17:41:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYan4fEvJP/Listeners', 17:41:24 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:41:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:24 INFO - 'USER': 'cltbld', 17:41:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:24 INFO - 'XPC_FLAGS': '0x0', 17:41:24 INFO - 'XPC_SERVICE_NAME': '0', 17:41:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:41:24 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-ILBcDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:41:24 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-JIWbm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:41:24 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-wnnHbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:41:24 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-9XsSKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:41:24 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-G8G9zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:41:24 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Qjdqys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:41:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-u_RCg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:41:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-ADDUOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:41:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-vTCr7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:41:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-fM7EbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:41:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-YNhRdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:41:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-t3IGlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:41:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Uq63lC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:41:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-4vOy9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-019n3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:41:26 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-PUWCeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:41:26 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-SgWtmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:41:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:41:26 INFO - Running setup.py install for manifestparser 17:41:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:41:26 INFO - Running setup.py install for mozcrash 17:41:26 INFO - Running setup.py install for mozdebug 17:41:26 INFO - Running setup.py install for mozdevice 17:41:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:41:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:41:26 INFO - Running setup.py install for mozfile 17:41:26 INFO - Running setup.py install for mozhttpd 17:41:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:41:27 INFO - Running setup.py install for mozinfo 17:41:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:41:27 INFO - Running setup.py install for mozInstall 17:41:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:41:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:41:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:41:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:41:27 INFO - Running setup.py install for mozleak 17:41:27 INFO - Running setup.py install for mozlog 17:41:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:41:27 INFO - Running setup.py install for moznetwork 17:41:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:41:27 INFO - Running setup.py install for mozprocess 17:41:28 INFO - Running setup.py install for mozprofile 17:41:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:41:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:41:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:41:28 INFO - Running setup.py install for mozrunner 17:41:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:41:28 INFO - Running setup.py install for mozscreenshot 17:41:28 INFO - Running setup.py install for moztest 17:41:28 INFO - Running setup.py install for mozversion 17:41:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:41:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:41:28 INFO - Cleaning up... 17:41:28 INFO - Return code: 0 17:41:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41: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')]} 17:41:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41: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')]} 17:41:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:28 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 0x10808fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108124618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae3a490e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ff3d30>, '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 0x107d58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107febb20>, '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.iv0lE1QZz8/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.YYan4fEvJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:41:28 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 17:41:28 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 17:41:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv0lE1QZz8/Render', 17:41:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:28 INFO - 'HOME': '/Users/cltbld', 17:41:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:28 INFO - 'LOGNAME': 'cltbld', 17:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:28 INFO - 'MOZ_NO_REMOTE': '1', 17:41:28 INFO - 'NO_EM_RESTART': '1', 17:41:28 INFO - 'PAGER': '/bin/cat', 17:41:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:28 INFO - 'PWD': '/builds/slave/test', 17:41:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:28 INFO - 'SHELL': '/bin/bash', 17:41:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYan4fEvJP/Listeners', 17:41:28 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:41:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:28 INFO - 'USER': 'cltbld', 17:41:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:28 INFO - 'XPC_FLAGS': '0x0', 17:41:28 INFO - 'XPC_SERVICE_NAME': '0', 17:41:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:41:29 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-YhdwEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:41:29 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)) 17:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:41:29 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-K7zoZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:41:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:41:29 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-GzTpiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:41:29 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)) 17:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:41:29 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-2ssI2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:41:29 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)) 17:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:41:29 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-ynCEPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:41:29 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)) 17:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:41:29 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-FvxMmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:41:29 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)) 17:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:41:29 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-g8WDBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:41:29 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)) 17:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:41:29 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-1nst_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:41:29 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)) 17:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:41:29 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-YLj551-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:41:30 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)) 17:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:41:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-e452Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 17:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:41:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-nWN114-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:41:30 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)) 17:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:41:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-q6mAbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:41:30 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)) 17:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:41:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-MyIBeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:41:30 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)) 17:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:41:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-AXki3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-_FETS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:30 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)) 17:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:41:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-ACwQeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:41:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-zxjzr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:41:30 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)) 17:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:41:30 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)) 17:41:30 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)) 17:41:30 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)) 17:41:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:33 INFO - Downloading blessings-1.6.tar.gz 17:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:41:33 INFO - Installing collected packages: blessings 17:41:33 INFO - Running setup.py install for blessings 17:41:33 INFO - Successfully installed blessings 17:41:33 INFO - Cleaning up... 17:41:33 INFO - Return code: 0 17:41:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:41:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:41:34 INFO - Reading from file tmpfile_stdout 17:41:34 INFO - Current package versions: 17:41:34 INFO - blessings == 1.6 17:41:34 INFO - blobuploader == 1.2.4 17:41:34 INFO - docopt == 0.6.1 17:41:34 INFO - functools32 == 3.2.3-2 17:41:34 INFO - jsonschema == 2.5.1 17:41:34 INFO - manifestparser == 1.1 17:41:34 INFO - mozInstall == 1.12 17:41:34 INFO - mozcrash == 0.17 17:41:34 INFO - mozdebug == 0.1 17:41:34 INFO - mozdevice == 0.48 17:41:34 INFO - mozfile == 1.2 17:41:34 INFO - mozhttpd == 0.7 17:41:34 INFO - mozinfo == 0.9 17:41:34 INFO - mozleak == 0.1 17:41:34 INFO - mozlog == 3.3 17:41:34 INFO - moznetwork == 0.27 17:41:34 INFO - mozprocess == 0.23 17:41:34 INFO - mozprofile == 0.28 17:41:34 INFO - mozrunner == 6.12 17:41:34 INFO - mozscreenshot == 0.1 17:41:34 INFO - mozsystemmonitor == 0.3 17:41:34 INFO - moztest == 0.7 17:41:34 INFO - mozversion == 1.4 17:41:34 INFO - psutil == 3.1.1 17:41:34 INFO - requests == 1.2.3 17:41:34 INFO - wsgiref == 0.1.2 17:41:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:34 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 0x10808fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108124618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae3a490e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ff3d30>, '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 0x107d58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107febb20>, '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.iv0lE1QZz8/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.YYan4fEvJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:41:34 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 17:41:34 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 17:41:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv0lE1QZz8/Render', 17:41:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:34 INFO - 'HOME': '/Users/cltbld', 17:41:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:34 INFO - 'LOGNAME': 'cltbld', 17:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:34 INFO - 'MOZ_NO_REMOTE': '1', 17:41:34 INFO - 'NO_EM_RESTART': '1', 17:41:34 INFO - 'PAGER': '/bin/cat', 17:41:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:34 INFO - 'PWD': '/builds/slave/test', 17:41:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:34 INFO - 'SHELL': '/bin/bash', 17:41:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYan4fEvJP/Listeners', 17:41:34 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:41:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:34 INFO - 'USER': 'cltbld', 17:41:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:34 INFO - 'XPC_FLAGS': '0x0', 17:41:34 INFO - 'XPC_SERVICE_NAME': '0', 17:41:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:34 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)) 17:41:34 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)) 17:41:34 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)) 17:41:34 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)) 17:41:34 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)) 17:41:34 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)) 17:41:34 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)) 17:41:34 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)) 17:41:34 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)) 17:41:34 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)) 17:41:34 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)) 17:41:34 INFO - Cleaning up... 17:41:34 INFO - Return code: 0 17:41:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10808fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108124618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae3a490e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ff3d30>, '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 0x107d58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107febb20>, '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.iv0lE1QZz8/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.YYan4fEvJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:41:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv0lE1QZz8/Render', 17:41:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:34 INFO - 'HOME': '/Users/cltbld', 17:41:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:34 INFO - 'LOGNAME': 'cltbld', 17:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:34 INFO - 'MOZ_NO_REMOTE': '1', 17:41:34 INFO - 'NO_EM_RESTART': '1', 17:41:34 INFO - 'PAGER': '/bin/cat', 17:41:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:34 INFO - 'PWD': '/builds/slave/test', 17:41:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:34 INFO - 'SHELL': '/bin/bash', 17:41:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYan4fEvJP/Listeners', 17:41:34 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:41:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:34 INFO - 'USER': 'cltbld', 17:41:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:34 INFO - 'XPC_FLAGS': '0x0', 17:41:34 INFO - 'XPC_SERVICE_NAME': '0', 17:41:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:41:34 INFO - Cleaning up... 17:41:34 INFO - Return code: 0 17:41:34 INFO - Running post-action listener: _resource_record_post_action 17:41:34 INFO - Running post-action listener: _start_resource_monitoring 17:41:34 INFO - Starting resource monitoring. 17:41:34 INFO - [mozharness: 2016-08-08 00:41:34.577599Z] Finished create-virtualenv step (success) 17:41:34 INFO - [mozharness: 2016-08-08 00:41:34.578541Z] Running install step. 17:41:34 INFO - Running pre-action listener: _resource_record_pre_action 17:41:34 INFO - Running main action method: install 17:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:41:34 INFO - Reading from file tmpfile_stdout 17:41:34 INFO - Detecting whether we're running mozinstall >=1.0... 17:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:41:34 INFO - Reading from file tmpfile_stdout 17:41:34 INFO - Output received: 17:41:34 INFO - Usage: mozinstall [options] installer 17:41:34 INFO - Options: 17:41:34 INFO - -h, --help show this help message and exit 17:41:34 INFO - -d DEST, --destination=DEST 17:41:34 INFO - Directory to install application into. [default: 17:41:34 INFO - "/builds/slave/test"] 17:41:34 INFO - --app=APP Application being installed. [default: firefox] 17:41:34 INFO - mkdir: /builds/slave/test/build/application 17:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:42:09 INFO - Reading from file tmpfile_stdout 17:42:09 INFO - Output received: 17:42:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:42:09 INFO - Running post-action listener: _resource_record_post_action 17:42:09 INFO - [mozharness: 2016-08-08 00:42:09.030507Z] Finished install step (success) 17:42:09 INFO - [mozharness: 2016-08-08 00:42:09.030636Z] Running run-tests step. 17:42:09 INFO - Running pre-action listener: _resource_record_pre_action 17:42:09 INFO - Running main action method: run_tests 17:42:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:42:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:42:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:42:09 INFO - 2016-08-07 17:42:09.045 screenresolution[1655:8467] starting screenresolution argv=screenresolution get 17:42:09 INFO - 2016-08-07 17:42:09.047 screenresolution[1655:8467] Display 0: 1600x1200x32@60 17:42:09 INFO - 2016-08-07 17:42:09.053 screenresolution[1656:8469] starting screenresolution argv=screenresolution list 17:42:09 INFO - Available Modes on Display 0 17:42:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:42:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:42:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:42:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:42:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:42:09 INFO - Intel Iris: 17:42:09 INFO - Chipset Model: Intel Iris 17:42:09 INFO - Type: GPU 17:42:09 INFO - Bus: Built-In 17:42:09 INFO - VRAM (Dynamic, Max): 1536 MB 17:42:09 INFO - Vendor: Intel (0x8086) 17:42:09 INFO - Device ID: 0x0a2e 17:42:09 INFO - Revision ID: 0x0009 17:42:09 INFO - Displays: 17:42:09 INFO - Display: 17:42:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:42:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:42:09 INFO - Display Serial Number: 1600x1200 60 17:42:09 INFO - Main Display: Yes 17:42:09 INFO - Mirror: Off 17:42:09 INFO - Online: Yes 17:42:09 INFO - Rotation: Supported 17:42:09 INFO - Return code: 0 17:42:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:42:09 INFO - Python 2.7.3 17:42:09 INFO - Return code: 0 17:42:09 INFO - grabbing minidump binary from tooltool 17:42:09 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')]} 17:42:09 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 0x107ff3d30>, '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 0x107d58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107febb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:42:09 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 17:42:09 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 17:42:09 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 17:42:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:42:09 INFO - Return code: 0 17:42:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:42:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:42:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:42:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:42:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:42:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0289', '--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 17:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0289 --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 17:42:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv0lE1QZz8/Render', 17:42:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:09 INFO - 'HOME': '/Users/cltbld', 17:42:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:09 INFO - 'LOGNAME': 'cltbld', 17:42:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:42:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:09 INFO - 'MOZ_NO_REMOTE': '1', 17:42:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:42:09 INFO - 'NO_EM_RESTART': '1', 17:42:09 INFO - 'PAGER': '/bin/cat', 17:42:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:09 INFO - 'PWD': '/builds/slave/test', 17:42:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:42:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:09 INFO - 'SHELL': '/bin/bash', 17:42:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYan4fEvJP/Listeners', 17:42:09 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:42:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:09 INFO - 'USER': 'cltbld', 17:42:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:09 INFO - 'XPC_FLAGS': '0x0', 17:42:09 INFO - 'XPC_SERVICE_NAME': '0', 17:42:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0289', '--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 17:42:09 INFO - mozversion application_buildid: 20160807150152 17:42:09 INFO - mozversion application_changeset: ad2be3aadc626da670b5d0dd60e19afe2108b25b 17:42:09 INFO - mozversion application_display_name: Nightly 17:42:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:42:09 INFO - mozversion application_name: Firefox 17:42:09 INFO - mozversion application_remotingname: firefox 17:42:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:42:09 INFO - mozversion application_vendor: Mozilla 17:42:09 INFO - mozversion application_version: 51.0a1 17:42:09 INFO - mozversion platform_buildid: 20160807150152 17:42:09 INFO - mozversion platform_changeset: ad2be3aadc626da670b5d0dd60e19afe2108b25b 17:42:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:42:09 INFO - mozversion platform_version: 51.0a1 17:42:09 INFO - using testdate: 1470616929 17:42:09 INFO - actual date: 1470616929 17:42:09 INFO - starting webserver on 'localhost:49278' 17:42:09 INFO - SUITE-START | Running 2 tests 17:42:09 INFO - TEST-START | dromaeo_css 17:42:09 INFO - operating with platform_type : mac_ 17:42:09 INFO - Initialising browser for dromaeo_css test... 17:42:09 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpiqh_nM/profile http://localhost:49278/getInfo.html) 17:42:12 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 17:42:12 INFO - PROCESS | 1666 | colorDepth:24 17:42:12 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 17:42:12 INFO - PROCESS | 1666 | __metrics 17:42:12 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:42:13 INFO - TEST-INFO | 1666: exit 0 17:42:13 INFO - Browser initialized. 17:42:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:42:13 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpiqh_nM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:42:25 INFO - PROCESS | 1670 | RSS: Main: 254771200 17:42:25 INFO - PROCESS | 1670 | 17:43:14 INFO - PROCESS | 1670 | 1470616994993 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:45:26 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 17:45:28 INFO - PROCESS | 1670 | RSS: Main: 267968512 17:45:28 INFO - PROCESS | 1670 | 17:48:30 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 17:48:31 INFO - PROCESS | 1670 | RSS: Main: 280403968 17:48:31 INFO - PROCESS | 1670 | 17:51:33 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 17:51:33 INFO - PROCESS | 1670 | RSS: Main: 287539200 17:51:33 INFO - PROCESS | 1670 | 17:54:35 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 17:54:36 INFO - PROCESS | 1670 | RSS: Main: 287670272 17:54:36 INFO - PROCESS | 1670 | 17:57:39 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 17:57:39 INFO - PROCESS | 1670 | RSS: Main: 292073472 17:57:39 INFO - PROCESS | 1670 | 18:00:42 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 18:00:42 INFO - PROCESS | 1670 | RSS: Main: 292315136 18:00:42 INFO - PROCESS | 1670 | 18:00:42 INFO - PROCESS | 1670 | __start_tp_report 18:00:42 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 18:00:42 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 18:00:42 INFO - PROCESS | 1670 | |i|pagename|runs| 18:00:42 INFO - PROCESS | 1670 | |0;dojo.html;2894.9276268093304;2979.4636965346235;3368.6294507604175;3370.2922386298874;3380.205651671858;4605.424321959755;5535.750891209896;5590.273264475618;5595.132754423066;5634.239377684022;4673.556012178846;5594.804181853636;5610.382857885639;5611.466910643492;5622.4939755422;5069.062223488648;5133.383993920716;5141.1003074462005;5217.034848553029;5238.895222095556;4699.130660827758;5094.261332106842;5184.585233181355;5214.191800270964;5270.7628156733035;5052.8484145475695;5106.974465127688;5140.588752899796;5141.948580514184;5151.253068305094;5094.184930411154;5144.871378215537;5149.407818100892;5182.740862956837;5230.529252367267;5069.518395752398;5134.922976155361;5149.716765577892;5154.304168937183;5163.380394352665;5426.131818908955;5436.510714035716;5537.8061767838335;5604.691741954191;5612.438756124396;6109.3890610939;6138.770160990056;6141.140240366352;6156.969215153896;6166.013437849922;6165.537584681167;6182.783602573933;6196.690165491753;6206.410391012847;6222;5599.076152434803;5638.887222255532;5695.145728140812;5696.401877802854;5842.18209450673;6125.571210015256;6138;6152.600080994721;6163.9383606163365;6180;5907;6059.333473317932;6061.909071363933;6063.939360606426;6081.209442772411;6045.153678485016;6046.818595442144;6113.174721412553;6138.294096178907;6156.29202641693;6069.3627169147485;6100.611450805989;6121.6358891611635;6135.04893764628;6148.678034222664;6091.02543593023;6099.536002066622;6115.550245189573;6124.341790330294;6151.384861513902;4735.857924262277;4805;4842.6368022398465;4938.604911607063;4945.9752701236985;4370.060437006059;4373.825046998148;4404.07514421975;4453.354263631755;4494.438195225597;4607.956490886824;5551.916721249185;5564.527015203753;5570.08093664549;5582.33012038558;6006.309274433496;6090.36051214625;6116.174316467309;6131.386861313833;6154.446099851035;5641.153826925912;5685.260916080883;5688.715564221772;5698.971505142447;5731.856703582361;5389.67661940277;5402.432744561843;5403.108487099585;5410.91883621746;5420.159875219348;6099.037411928083;6140.846478837886;6179.598326108789;6202.751889924442;6224.844378890564;6130.141780150871;6147.831911936718;6156.322804491413;6163.84590385244;6209.844753881189;6176.876462470816;6185.134081228722;6201.937980620136;6206.286277078013;6208.317085120543;5105.28526006352;5969.164316995711;5992.340842507234;6099.207103076572;6121.816345509642;6139.140520327069;6142.7136481981925;6144.723487443165;6167.6916154193;6180.81457556256;5858.209141765807;6030.7286172121485;6032.215811944595;6060.090986352083;6087.208662873798;5791.333996590278;5878.941210587839;5923.08192230205;5953.987822070345;6067.635941843503;5488.56091512686;5797.101449275369;5825.825225243249;5841.766329346779;5855.619384739978;6002.249718785152;6003.129546215861;6058.939410606014;6084.513238940785;6105.14527966094;5855.180274761622;5877.35349111606;5882.1470886722045;5907.940920590911;5914.585978981602 18:00:42 INFO - PROCESS | 1670 | |1;ext.html;481.5521564944601;514.9974250128748;526.8577484079298;528.4345750047446;538.1873371209473;32314.353712925727;41003.38494922575;41010;41071.17857642853;41120.79439602805;41312.38031429523;41733.79133104338;41779.373309400384;41840.79079604605;41956.37065444021;9608.135267825877;9849.310548261625;9850.064243896853;9850.655227067055;9864.654737084204;9743.610255589769;9761.853572196424;9841;9843.212542996544;9894.406335619886;9842.753931151707;9862.45756483393;9864.112229899307;9867.40795552269;9884.209263258957;9793.951030244874;9795.167410770022;9834.508274586278;9864.013598640151;9880.061394167542;9591.760205994837;9654.131128198425;9664.95167524165;9754.707358779247;9763.707088787347;39485.21029579392;39702.60297397018;39798.60201397978;39853.40219896704;39882.60117398818;3108.782385233035;3292.8682852685865;3361.2605226850055;3430.3310854383403;4064.5935406459116;31223.375532489223;31472.685273147203;31741.523877141863;31992.840035799905;32038.679613203803;3196.4246435641576;3216.4049650814673;3219.1791093271067;3234.56333394991;3347.0460918638073;511727.8827211755;514735;522828;523591;524444;59702;59916;60041.39958600445;60061.39938600558;60123.09815352773;34266;35342.82328588392;35677.46483802745;62446.37553624497;62993.370066298754;14762.70474590502;16305.02169869788;16465.506034818976;16500.75248871268;16530.504084877473;11492.540298388138;11678;11785.410729463492;11834.585789497327;11864;16048.839511604969;19390;19439.930803805928;19442.319518816774;19481.415557533295;8132;8223.176223056307;8237.752867413987;8279.8344033119;8323.958380208182;899.5367385796189;938.9154976052188;950.805084957582;984.5963155106372;1017.9565944906531;26683.33291667685;29614.259643509085;29914.40171196564;30797.23006924845;31208.687913121033;1070.6520380876245;1086.3481910853425;1117.3296022386667;1139.6182278936483;1171.841801356806;14452.988290819541;15084.698306033817;15307.311170997333;15948.2823272953;15958.9202053989;677340;685667;687199;687413.6887946685;687909;57979.71010144922;59596.10605840916;59670.70164649236;59733.70133149307;59846.70076649589;1346.1721041559567;1376.4700590272816;1393.7212557488542;1396.1762560089596;1399.1185553101482;30087.778933056346;30255;30519.38961220719;30798.69201308048;30911.536326954665;50615.240771387726;50672.74663626658;50759.2386114216;50964.49035509597;51028;602644;606228;608634;612341;612868;26553.20423238202;26724.797384117373;26759.260648057814;27115.59326610063;27172.864135679196;47871.28193077037;48374.75812620914;48594.514054859;49647.25529116994;49825;39685.00787480336;39754.80122599369;40081;40898.9775255621;41284.79357603193;39815.00462488461;40012.99967500836;40174;40388.59611403966;41445.171096577295;33004;33005.834970824995;35816;38836.029099272746;39110.6088939107;33854.8307258472;34600.82699586486;34716;35035.824820875736;35562.28875422529;25679.972801087748;25983.622129123094;26090.73909260883;26325.60511592366;26590.335241619116 18:00:42 INFO - PROCESS | 1670 | |2;jquery.html;348.7854969193946;353.9452431753375;365.8628014494563;390.96676782473486;403.2902092317522;19790.30733924313;19821.603567928632;20575.485612859688;20590.89704551479;20763.896180519114;11967.46146423411;12105.15263931525;17657;19710;20808.68786968193;5436.537894278991;5629.662220266797;5631.831045068655;5639.984802735506;5643.717814109299;5734.254546908896;6026.879462410771;6096.695165241742;6103.542234332421;6113.755449782026;5097.923531147036;6040.818775436722;6056.848578785522;6108.786192483264;6109.205803245572;5322.2282768998475;6064.151018857364;6118.785842495514;6161.7535298588;6210.472109870644;5894.440028197314;5911.379305172938;6031.4270144336215;6032.155498230251;6039.818805435844;13002;13212.471501139942;13667.043306968517;13840.792388114187;13898.93050534751;2158.3956492182056;2184.2573525001417;2235.832312576547;2436.9634455483183;3041.300500884809;16843.32626694931;16920.661586768318;17054.317827286894;17426.302947882068;18313.450596482126;1926.5280006398382;1956.7847536770944;2000.4398768344886;2073.8340932725346;2125.3836387447623;119340;142229;142293.2885335577;145858;156701;21284.403669724834;21688.674669879965;22075.448113797283;22293.442663933532;22331.761894525203;35473.82263088668;36261.45607815885;36321.72873949399;36336;36407;10597.41714205726;10609.787804243872;10991.945040274748;11036.337819730841;11173.664790056311;8911.643534258686;8998.820023599492;9015.504147271962;9142.3600347975;9161.312901532412;8100.554469504116;9795.363301385387;9891.406515608942;9995.350302230332;10051.095401413762;3855.190410013872;3883.514560679915;3907.9218415631526;3920.4903362562686;3924.9803750981064;870.3776799588325;911.8221946720458;961.8990006049404;994.7065615643403;1015.8730158730159;21550.461238469165;22303.44241393978;22375;22721.886390568274;22889.771102288763;903.3315346643568;917.8944421391625;939.9436033837992;955.3121752338305;959.2326139088701;8975.192232698957;10223.539940702687;11337.43312834355;11835.349055802013;11893.583724569598;538045;599044;600566;602828;618197;71954.64022679852;74804.62597686976;110783.44608276906;128015;148092.25953870162;972.7033254857195;1002.4912506677404;1004.0561871840447;1011.2112552209288;1020.9795804084025;19521;19976.800231997495;20002.499937501678;20108.69836952476;20267.898660506602;43597.69206923797;47836.54084988331;52675.47324526706;57675.42324576701;58632.82734345204;72079.86854553645;88735.66896496428;88940;89699.20601587801;90758;6920.238773734985;8160.714374996846;8255.174482551696;8285.25432711059;8508.936382952132;9241.491717955578;12762.87237127654;13158.671033224246;13404.463821447032;13740.862591374358;9512.906015807994;11545.653630391102;11751.471183796579;11802.645920622395;11852.822207667065;9335.859962100438;11562.76874462523;11563.884361156617;11587.42062896835;11921.225120367148;11544.59593914209;11659.650210493699;11880.168388213087;11911.880881191424;11984.820227696766;7021.876499760014;7130.786076417716;8114.472559283628;8127.918720812716;8295.917040829514;8335.708250211213;10745.623903163352;10995.890041099487;11370.20408571392;11828 18:00:42 INFO - PROCESS | 1670 | |3;mootools.html;1511.9794138956206;1550.4960887711495;1737.4787563730886;1794.111914602272;1825.4614888607869;8054.516728996265;8376.832463350729;8579.18497742715;8861.202491775739;8888.822223555526;8172.795680107985;8315.958420207891;8680.826383472328;8836.602352894119;8839.955800221005;2335.5912715274844;2381.30942026812;2385.129427758864;2385.3082606044227;2390.5577468168444;2317.536492701458;2350.459394339303;2394.042383046778;2396.4128788446856;2397.6883005209384;2354.5173239485866;2370.182287110944;2378.916737914173;2397.1250493569896;2403.483251101013;2356.9528609427716;2370.8577485350934;2370.988145059281;2376.3346263046374;2377.63146712259;2313.664518644804;2333.404981729665;2350.1656911796235;2358.681577986967;2358.8466749661216;8896.8665470018;8896.955515222448;8941.46351218929;8966.820663586757;9019.278457723367;5225.6603320784025;5344.732763361816;5349.277847490578;5357.758900849432;5358.812441564526;3540.6990405815536;3566.6076731559506;3582.5521809773777;3614.7469677122613;3640.290143422034;1072.9017927970774;1075.2473268711933;1082.577794660083;1087.152021423291;1092.9344239345664;11351.943240283828;11440.656780296604;11507.309561426258;11535.596254131066;11587.478563464665;4484.080763443486;4578.221702310615;4701.130290896127;4722.079194557028;4733.455652599995;9907.25695572835;9980.401175929468;10003.399796012263;10008.299419040597;10013.148882345082;5169.612279079084;5183.352080989876;5226.425093239741;5227.686338819683;5254.369475662945;4359.476862776487;4715.104130215317;4812.422509298836;4823.589994850407;4864.683795553277;3812.4853144825092;3937.5668676445566;3983.402489626579;3992.441058251847;4050.2709512287483;1123.7246874515795;1222.9816552751715;1273.7898246789362;1284.4862055178003;1289.8645642207432;923.1414784250711;939.5537119868145;940.6660635474445;945.4043952310001;987.683941138843;5241.764120614582;5984.461398474158;6080;6090.847728806727;6224.937750622526;881.6517475597232;899.2536194958169;955.7515046088067;975.2831668723625;1005.4319309590204;3955.3078211312904;4067.7355971861734;4118.238125946709;4185.204811085884;4222.0500387412585;10286.434246116385;10791.460426978776;10792.028717415471;10798.082163016075;10800.08199303068;10706.411147386969;10715.624953126604;10720.839187412195;10747.838782418114;10759.677209683721;7774.533527988338;8018.679252829821;8201.917980820235;8210.83578328442;8314.875276870851;5917.526597872074;5935.792247271324;6068.302145253352;6081.483073938764;6128.448439640454;9581.568829402555;9807.06832850878;9815.067568580973;9820.65627703027;9846.803063938538;9474.38416502925;9906.009399060325;9922.950385248028;9941.602335906482;9997.850032249376;7037.049998250375;7351.3751331137455;7469.402447804054;7475.401967842451;7632;8365.581720913808;8367.037790653909;8429.199226073513;8435.156484351515;8439.70461033861;7378.520396174232;7393.815154620962;7590.278923502258;7659.923400765921;7680.462367634212;7335.7432489862595;7461.95532625422;7475.588842613708;7570.394368450621;7654.119776225805;6987.161540615159;7116.217216106121;7117.39502142303;7135.42916566663;7142.035825163744;4965.3296804932315;4982.501749824988;5081.18701007837;5096.159133742891;5135.614828887774;4979.103761322852;5040.470750571138;5153.123968925217;5153.819616313411;5254.13306804373 18:00:42 INFO - PROCESS | 1670 | |4;prototype.html;299.23694578824006;308.48791006928496;314.61931063413266;315.9810411375317;318.02683787609914;4715.976420117895;5527;5595.608307418483;5728.856778580537;5765.250517432738;5514.531264842483;5567.325565127017;5569.136783798507;5582.7766889324375;5603.719814009293;3961.742486738353;3974.8671628585857;4110.609492098246;4280.566010386524;4301.440812694345;3991.6207960243732;4141.337386018237;4255.616994470497;4278.679099067583;4331.7617531035785;3572.9821350893208;3834.9424758628643;3856.3251430999603;4222.746635201897;4223.387608796723;3196.922000699564;3326.7338612910908;3732.2348918471785;4057.7623824733446;4090.570490098556;3197.289450144185;3616.674499295076;3694.9815250923843;3696.464012718141;3720.2373513429684;5328.147496400596;5377.091132647893;5410.323709536308;5414.3232095988005;5432.674039557639;4906;4906.705597664116;4909.828156014558;4925.261210818406;4938.728369939688;5603.691796951166;5920.911186332209;5949.345571987078;5952.529700174466;5992.730327135289;3950.012496875781;4011.478507793968;4033.757974521509;4067;4067.28822456069;5447.509724124809;6244.470104824301;6265.8120256392385;6322.020086886586;6335.271443783978;3483.397637086968;3928.2339943710704;4105.261053010427;4119.670426365884;4140.37894315855;3625.492431059654;3826.5408151022057;4093.9385909211387;4113.506379234451;4115.7324773890205;4432.800523976429;4803.423589169322;4817.421909370828;4837.685550439211;4854.732989685601;5244.895102098013;5944.256967879015;5983.65367792252;5984.132300816357;6024.258962172201;1310.6461255460972;1338.3642769684323;1366.9726605467836;1375.5735721926235;1403.4316101978511;771.9768406947801;780.2392667149597;820.5035953248199;829.3531045784177;864.5158711121666;4417.359482874966;4591.028760122536;4619.884502887455;4635.513271106553;4672.719636821734;5098.490150984946;5099.6685215460875;5104.464031276737;5108.923366149511;5140.151874940668;4417.6431398675695;4605.332226827091;4637.39713837199;4692.929606055912;4701.318308845198;2301.4821665125546;2521.4704911968693;2605.960910586343;2680.852553109559;2694.851783151906;4486.887827804266;4771.642126840501;5212.9052898890895;5271.42014378418;5279.973600131974;4754.95245047552;5031.622628302892;5253.317068781034;5268.525832675077;5277.366715994105;5678.886422271614;6326.41839540115;6383.329750376237;6424.691283988843;6435.678216089177;5048.671836330626;6220.315765265726;6257.342978987323;6266.310705822265;6313.621182729051;5077;5097.898042039213;5764.567657425626;6125.938740612537;6178.505719542336;5294.179402192666;5520.779168833363;6144.477719393902;6229.595076320024;6388.584741991755;3679.889603311905;3840.7695538267794;3926.941095883621;3996.6802655788047;4092.549819519791;5098.643094983316;5376.946230537801;6051.5461340400525;6094.39056094387;6104;5953.345132035386;5974;6007.219061521974;6016.789412370546;6042.305134909541;5382.30030096085;5630.211770352236;5769;5905.911411328748;5911.615744976562;5831.94168058314;5849.64902105875;5863.768608592243;5873.765049397976;5885.176075349369;5401.595585147811;5412.025835349675;5935.527716286021;5975.820725378246;5984.551158663031;5164.664296820694;5767.106098554731;5912.688894219251;5974.850628734316;5977.790777322947 18:00:42 INFO - PROCESS | 1670 | |5;yui.html;673.6227712481011;759.4683721395024;777.3431450424397;814.9470284431512;843.4915377308286;14699.779503307445;15031.549053528384;15193.544193674179;15208.847911520881;15211.847881521182;14187.219702916336;14222.217778022205;14255.3585088671;14336.068155569881;14369.78445323321;688.8656711941173;857.4041041476177;880.7225723896952;883.2492381475759;885.3846576629245;851.9148085191463;860.8837806896083;877.8990416102134;888.1473785166248;888.3293113699148;906.7914379692675;934.3739694404765;938.6057855700589;939.9201067909202;942.3309450290268;922.4511415707643;933.6638810028385;934.6168071090854;935.0976307862911;935.6023689931752;693.8855088910324;695.9652017399161;695.9721611135549;697.2817997462571;697.8360085379932;14622.195779232137;14663.193524356157;14924.552263432115;14958.476453324081;14983.925080374638;13032.348382580927;14630;14706.705865882623;14856.554303370916;14902.627434314121;11907.345096019715;11990;12083;12086;12207.511699532097;3871.7870517121546;3877.3408520551293;3902.5902280260448;3939.9212015759813;4044;112952;115060;119914.35540519723;122093.77906221001;122915.38542307321;10311.329763565343;10484.580616775243;10743.355398676105;10844.024037836632;10990.835137472945;21105.57788844245;21368.358949231548;21576.029078691496;21601.78398216029;21647.891760541097;7701.345385642171;7718.53688778675;7729.420293478011;7803.141654418009;7888.092869319987;4373.584509471595;4397.912041759147;4416.7593474606565;4459.420275364182;4532.88667783308;3463.6882680558365;3546.5212196353164;3553.626869178751;3591.7665351752053;3595.5146055282726;616.5868867858545;641.7588947485757;653.4543656047159;655.6885479397248;656.1830521001289;604.7792555717132;607.3380015782818;632.3423639414957;635.9459445947147;639.6354078175395;9019.323550733721;9201.263898888074;9233.815323693489;9241.013182165867;9277.67528136512;493.7580585513073;499.807574083973;596.3648714119449;645.2482857471088;648.8799572079181;3825.483559719458;3849.034517308262;4430.180416622935;4558.635309175258;4624.075184963021;169245;174425;174676;176592.93628254725;181943.09028454774;131491.34254328857;134468;137072.0577099359;139310.99999999796;139660;106140;122476.38761806134;124551;124850;129283.35358323336;8270.793230169294;8662.956685216786;8674.436161649473;8777.692780752643;8793.160764700368;66170.66914665588;68747.65626171837;70216.29783702303;71066.64466677634;72946;84996.57501712452;92435;106129;107741.46129269303;107777.46111269394;11184.88815111871;11315.547378104784;11315.660530184108;11517.942410287895;11638.607913615078;10952.39761813076;12379.257244565355;12405.317707525812;12417.62747117588;12581.622551323475;11650.70873228176;11993.76012479728;12121.515139394325;12261.534332097262;12285.463399057991;11677.017393214355;11931.164818462625;11957.282563046245;12111.091668125102;12336.691582710504;11647.825282620597;11887.405629718653;12060.396980151132;12277.20198187115;12317.384130793604;9720.659776908056;9856.408615483095;9986.251031172837;10301.587936482756;10404.583816647551;8533.658653653783;9107.453552786854;9741.220702343653;10032.548535315782;10201 18:00:42 INFO - PROCESS | 1670 | __end_tp_report 18:00:42 INFO - PROCESS | 1670 | __start_cc_report 18:00:42 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,426 18:00:42 INFO - PROCESS | 1670 | __end_cc_report 18:00:42 INFO - PROCESS | 1670 | __startTimestamp1470618042539__endTimestamp 18:00:42 INFO - PROCESS | 1670 | 18:00:42 INFO - PROCESS | 1670 | ------- Summary: start ------- 18:00:42 INFO - PROCESS | 1670 | Number of tests: 6 18:00:42 INFO - PROCESS | 1670 | 18:00:42 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5629.42 Median:5855.62 stddev:649.94 (11.1%) stddev-sans-first:615.51 18:00:42 INFO - PROCESS | 1670 | Values: 2894.9 2979.5 3368.6 3370.3 3380.2 4605.4 5535.8 5590.3 5595.1 5634.2 4673.6 5594.8 5610.4 5611.5 5622.5 5069.1 5133.4 5141.1 5217.0 5238.9 4699.1 5094.3 5184.6 5214.2 5270.8 5052.8 5107.0 5140.6 5141.9 5151.3 5094.2 5144.9 5149.4 5182.7 5230.5 5069.5 5134.9 5149.7 5154.3 5163.4 5426.1 5436.5 5537.8 5604.7 5612.4 6109.4 6138.8 6141.1 6157.0 6166.0 6165.5 6182.8 6196.7 6206.4 6222.0 5599.1 5638.9 5695.1 5696.4 5842.2 6125.6 6138.0 6152.6 6163.9 6180.0 5907.0 6059.3 6061.9 6063.9 6081.2 6045.2 6046.8 6113.2 6138.3 6156.3 6069.4 6100.6 6121.6 6135.0 6148.7 6091.0 6099.5 6115.6 6124.3 6151.4 4735.9 4805.0 4842.6 4938.6 4946.0 4370.1 4373.8 4404.1 4453.4 4494.4 4608.0 5551.9 5564.5 5570.1 5582.3 6006.3 6090.4 6116.2 6131.4 6154.4 5641.2 5685.3 5688.7 5699.0 5731.9 5389.7 5402.4 5403.1 5410.9 5420.2 6099.0 6140.8 6179.6 6202.8 6224.8 6130.1 6147.8 6156.3 6163.8 6209.8 6176.9 6185.1 6201.9 6206.3 6208.3 5105.3 5969.2 5992.3 6099.2 6121.8 6139.1 6142.7 6144.7 6167.7 6180.8 5858.2 6030.7 6032.2 6060.1 6087.2 5791.3 5878.9 5923.1 5954.0 6067.6 5488.6 5797.1 5825.8 5841.8 5855.6 6002.2 6003.1 6058.9 6084.5 6105.1 5855.2 5877.4 5882.1 5907.9 5914.6 18:00:42 INFO - PROCESS | 1670 | 18:00:42 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:72921.49 Median:22226.59 stddev:162813.56 (732.5%) stddev-sans-first:163179.45 18:00:42 INFO - PROCESS | 1670 | Values: 481.6 515.0 526.9 528.4 538.2 32314.4 41003.4 41010.0 41071.2 41120.8 41312.4 41733.8 41779.4 41840.8 41956.4 9608.1 9849.3 9850.1 9850.7 9864.7 9743.6 9761.9 9841.0 9843.2 9894.4 9842.8 9862.5 9864.1 9867.4 9884.2 9794.0 9795.2 9834.5 9864.0 9880.1 9591.8 9654.1 9665.0 9754.7 9763.7 39485.2 39702.6 39798.6 39853.4 39882.6 3108.8 3292.9 3361.3 3430.3 4064.6 31223.4 31472.7 31741.5 31992.8 32038.7 3196.4 3216.4 3219.2 3234.6 3347.0 511727.9 514735.0 522828.0 523591.0 524444.0 59702.0 59916.0 60041.4 60061.4 60123.1 34266.0 35342.8 35677.5 62446.4 62993.4 14762.7 16305.0 16465.5 16500.8 16530.5 11492.5 11678.0 11785.4 11834.6 11864.0 16048.8 19390.0 19439.9 19442.3 19481.4 8132.0 8223.2 8237.8 8279.8 8324.0 899.5 938.9 950.8 984.6 1018.0 26683.3 29614.3 29914.4 30797.2 31208.7 1070.7 1086.3 1117.3 1139.6 1171.8 14453.0 15084.7 15307.3 15948.3 15958.9 677340.0 685667.0 687199.0 687413.7 687909.0 57979.7 59596.1 59670.7 59733.7 59846.7 1346.2 1376.5 1393.7 1396.2 1399.1 30087.8 30255.0 30519.4 30798.7 30911.5 50615.2 50672.7 50759.2 50964.5 51028.0 602644.0 606228.0 608634.0 612341.0 612868.0 26553.2 26724.8 26759.3 27115.6 27172.9 47871.3 48374.8 48594.5 49647.3 49825.0 39685.0 39754.8 40081.0 40899.0 41284.8 39815.0 40013.0 40174.0 40388.6 41445.2 33004.0 33005.8 35816.0 38836.0 39110.6 33854.8 34600.8 34716.0 35035.8 35562.3 25680.0 25983.6 26090.7 26325.6 26590.3 18:00:42 INFO - PROCESS | 1670 | 18:00:42 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:36123.87 Median:17913.88 stddev:99129.74 (553.4%) stddev-sans-first:99371.43 18:00:42 INFO - PROCESS | 1670 | Values: 348.8 353.9 365.9 391.0 403.3 19790.3 19821.6 20575.5 20590.9 20763.9 11967.5 12105.2 17657.0 19710.0 20808.7 5436.5 5629.7 5631.8 5640.0 5643.7 5734.3 6026.9 6096.7 6103.5 6113.8 5097.9 6040.8 6056.8 6108.8 6109.2 5322.2 6064.2 6118.8 6161.8 6210.5 5894.4 5911.4 6031.4 6032.2 6039.8 13002.0 13212.5 13667.0 13840.8 13898.9 2158.4 2184.3 2235.8 2437.0 3041.3 16843.3 16920.7 17054.3 17426.3 18313.5 1926.5 1956.8 2000.4 2073.8 2125.4 119340.0 142229.0 142293.3 145858.0 156701.0 21284.4 21688.7 22075.4 22293.4 22331.8 35473.8 36261.5 36321.7 36336.0 36407.0 10597.4 10609.8 10991.9 11036.3 11173.7 8911.6 8998.8 9015.5 9142.4 9161.3 8100.6 9795.4 9891.4 9995.4 10051.1 3855.2 3883.5 3907.9 3920.5 3925.0 870.4 911.8 961.9 994.7 1015.9 21550.5 22303.4 22375.0 22721.9 22889.8 903.3 917.9 939.9 955.3 959.2 8975.2 10223.5 11337.4 11835.3 11893.6 538045.0 599044.0 600566.0 602828.0 618197.0 71954.6 74804.6 110783.4 128015.0 148092.3 972.7 1002.5 1004.1 1011.2 1021.0 19521.0 19976.8 20002.5 20108.7 20267.9 43597.7 47836.5 52675.5 57675.4 58632.8 72079.9 88735.7 88940.0 89699.2 90758.0 6920.2 8160.7 8255.2 8285.3 8508.9 9241.5 12762.9 13158.7 13404.5 13740.9 9512.9 11545.7 11751.5 11802.6 11852.8 9335.9 11562.8 11563.9 11587.4 11921.2 11544.6 11659.7 11880.2 11911.9 11984.8 7021.9 7130.8 8114.5 8127.9 8295.9 8335.7 10745.6 10995.9 11370.2 11828.0 18:00:42 INFO - PROCESS | 1670 | 18:00:42 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5723.11 Median:5144.37 stddev:3168.35 (61.6%) stddev-sans-first:3161.43 18:00:42 INFO - PROCESS | 1670 | Values: 1512.0 1550.5 1737.5 1794.1 1825.5 8054.5 8376.8 8579.2 8861.2 8888.8 8172.8 8316.0 8680.8 8836.6 8840.0 2335.6 2381.3 2385.1 2385.3 2390.6 2317.5 2350.5 2394.0 2396.4 2397.7 2354.5 2370.2 2378.9 2397.1 2403.5 2357.0 2370.9 2371.0 2376.3 2377.6 2313.7 2333.4 2350.2 2358.7 2358.8 8896.9 8897.0 8941.5 8966.8 9019.3 5225.7 5344.7 5349.3 5357.8 5358.8 3540.7 3566.6 3582.6 3614.7 3640.3 1072.9 1075.2 1082.6 1087.2 1092.9 11351.9 11440.7 11507.3 11535.6 11587.5 4484.1 4578.2 4701.1 4722.1 4733.5 9907.3 9980.4 10003.4 10008.3 10013.1 5169.6 5183.4 5226.4 5227.7 5254.4 4359.5 4715.1 4812.4 4823.6 4864.7 3812.5 3937.6 3983.4 3992.4 4050.3 1123.7 1223.0 1273.8 1284.5 1289.9 923.1 939.6 940.7 945.4 987.7 5241.8 5984.5 6080.0 6090.8 6224.9 881.7 899.3 955.8 975.3 1005.4 3955.3 4067.7 4118.2 4185.2 4222.1 10286.4 10791.5 10792.0 10798.1 10800.1 10706.4 10715.6 10720.8 10747.8 10759.7 7774.5 8018.7 8201.9 8210.8 8314.9 5917.5 5935.8 6068.3 6081.5 6128.4 9581.6 9807.1 9815.1 9820.7 9846.8 9474.4 9906.0 9923.0 9941.6 9997.9 7037.0 7351.4 7469.4 7475.4 7632.0 8365.6 8367.0 8429.2 8435.2 8439.7 7378.5 7393.8 7590.3 7659.9 7680.5 7335.7 7462.0 7475.6 7570.4 7654.1 6987.2 7116.2 7117.4 7135.4 7142.0 4965.3 4982.5 5081.2 5096.2 5135.6 4979.1 5040.5 5153.1 5153.8 5254.1 18:00:42 INFO - PROCESS | 1670 | 18:00:42 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:4651.38 Median:5102.07 stddev:1482.60 (29.1%) stddev-sans-first:1450.33 18:00:42 INFO - PROCESS | 1670 | Values: 299.2 308.5 314.6 316.0 318.0 4716.0 5527.0 5595.6 5728.9 5765.3 5514.5 5567.3 5569.1 5582.8 5603.7 3961.7 3974.9 4110.6 4280.6 4301.4 3991.6 4141.3 4255.6 4278.7 4331.8 3573.0 3834.9 3856.3 4222.7 4223.4 3196.9 3326.7 3732.2 4057.8 4090.6 3197.3 3616.7 3695.0 3696.5 3720.2 5328.1 5377.1 5410.3 5414.3 5432.7 4906.0 4906.7 4909.8 4925.3 4938.7 5603.7 5920.9 5949.3 5952.5 5992.7 3950.0 4011.5 4033.8 4067.0 4067.3 5447.5 6244.5 6265.8 6322.0 6335.3 3483.4 3928.2 4105.3 4119.7 4140.4 3625.5 3826.5 4093.9 4113.5 4115.7 4432.8 4803.4 4817.4 4837.7 4854.7 5244.9 5944.3 5983.7 5984.1 6024.3 1310.6 1338.4 1367.0 1375.6 1403.4 772.0 780.2 820.5 829.4 864.5 4417.4 4591.0 4619.9 4635.5 4672.7 5098.5 5099.7 5104.5 5108.9 5140.2 4417.6 4605.3 4637.4 4692.9 4701.3 2301.5 2521.5 2606.0 2680.9 2694.9 4486.9 4771.6 5212.9 5271.4 5280.0 4755.0 5031.6 5253.3 5268.5 5277.4 5678.9 6326.4 6383.3 6424.7 6435.7 5048.7 6220.3 6257.3 6266.3 6313.6 5077.0 5097.9 5764.6 6125.9 6178.5 5294.2 5520.8 6144.5 6229.6 6388.6 3679.9 3840.8 3926.9 3996.7 4092.5 5098.6 5376.9 6051.5 6094.4 6104.0 5953.3 5974.0 6007.2 6016.8 6042.3 5382.3 5630.2 5769.0 5905.9 5911.6 5831.9 5849.6 5863.8 5873.8 5885.2 5401.6 5412.0 5935.5 5975.8 5984.6 5164.7 5767.1 5912.7 5974.9 5977.8 18:00:42 INFO - PROCESS | 1670 | 18:00:42 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:26448.41 Median:3593.64 stddev:44473.16 (1237.6%) stddev-sans-first:44555.81 18:00:42 INFO - PROCESS | 1670 | Values: 673.6 759.5 777.3 814.9 843.5 14699.8 15031.5 15193.5 15208.8 15211.8 14187.2 14222.2 14255.4 14336.1 14369.8 688.9 857.4 880.7 883.2 885.4 851.9 860.9 877.9 888.1 888.3 906.8 934.4 938.6 939.9 942.3 922.5 933.7 934.6 935.1 935.6 693.9 696.0 696.0 697.3 697.8 14622.2 14663.2 14924.6 14958.5 14983.9 13032.3 14630.0 14706.7 14856.6 14902.6 11907.3 11990.0 12083.0 12086.0 12207.5 3871.8 3877.3 3902.6 3939.9 4044.0 112952.0 115060.0 119914.4 122093.8 122915.4 10311.3 10484.6 10743.4 10844.0 10990.8 21105.6 21368.4 21576.0 21601.8 21647.9 7701.3 7718.5 7729.4 7803.1 7888.1 4373.6 4397.9 4416.8 4459.4 4532.9 3463.7 3546.5 3553.6 3591.8 3595.5 616.6 641.8 653.5 655.7 656.2 604.8 607.3 632.3 635.9 639.6 9019.3 9201.3 9233.8 9241.0 9277.7 493.8 499.8 596.4 645.2 648.9 3825.5 3849.0 4430.2 4558.6 4624.1 169245.0 174425.0 174676.0 176592.9 181943.1 131491.3 134468.0 137072.1 139311.0 139660.0 106140.0 122476.4 124551.0 124850.0 129283.4 8270.8 8663.0 8674.4 8777.7 8793.2 66170.7 68747.7 70216.3 71066.6 72946.0 84996.6 92435.0 106129.0 107741.5 107777.5 11184.9 11315.5 11315.7 11517.9 11638.6 10952.4 12379.3 12405.3 12417.6 12581.6 11650.7 11993.8 12121.5 12261.5 12285.5 11677.0 11931.2 11957.3 12111.1 12336.7 11647.8 11887.4 12060.4 12277.2 12317.4 9720.7 9856.4 9986.3 10301.6 10404.6 8533.7 9107.5 9741.2 10032.5 10201.0 18:00:42 INFO - PROCESS | 1670 | -------- Summary: end -------- 18:00:42 INFO - PROCESS | 1670 | 18:00:43 INFO - TEST-INFO | 1670: exit 0 18:00:43 INFO - TEST-OK | dromaeo_css | took 1113549ms 18:00:43 INFO - TEST-START | kraken 18:00:43 INFO - operating with platform_type : mac_ 18:00:43 INFO - Initialising browser for kraken test... 18:00:43 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpLVVGuc/profile http://localhost:49278/getInfo.html) 18:00:45 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 18:00:45 INFO - PROCESS | 1678 | colorDepth:24 18:00:45 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 18:00:45 INFO - PROCESS | 1678 | __metrics 18:00:45 ERROR - PROCESS | 1678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 18:00:46 INFO - TEST-INFO | 1678: exit 0 18:00:46 INFO - Browser initialized. 18:00:46 INFO - Running cycle 1/1 for kraken test... 18:00:46 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpLVVGuc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:00:58 INFO - PROCESS | 1680 | RSS: Main: 254427136 18:00:58 INFO - PROCESS | 1680 | 18:01:01 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 18:01:02 INFO - PROCESS | 1680 | RSS: Main: 267132928 18:01:02 INFO - PROCESS | 1680 | 18:01:04 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 18:01:05 INFO - PROCESS | 1680 | RSS: Main: 275759104 18:01:05 INFO - PROCESS | 1680 | 18:01:08 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 18:01:09 INFO - PROCESS | 1680 | RSS: Main: 278343680 18:01:09 INFO - PROCESS | 1680 | 18:01:11 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 18:01:11 INFO - PROCESS | 1680 | RSS: Main: 280829952 18:01:11 INFO - PROCESS | 1680 | 18:01:13 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:01:14 INFO - PROCESS | 1680 | RSS: Main: 281661440 18:01:14 INFO - PROCESS | 1680 | 18:01:17 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 18:01:17 INFO - PROCESS | 1680 | RSS: Main: 281423872 18:01:17 INFO - PROCESS | 1680 | 18:01:21 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 18:01:21 INFO - PROCESS | 1680 | RSS: Main: 281935872 18:01:21 INFO - PROCESS | 1680 | 18:01:24 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 18:01:25 INFO - PROCESS | 1680 | RSS: Main: 282566656 18:01:25 INFO - PROCESS | 1680 | 18:01:27 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:01:27 INFO - PROCESS | 1680 | RSS: Main: 281784320 18:01:27 INFO - PROCESS | 1680 | 18:01:29 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:01:30 INFO - PROCESS | 1680 | RSS: Main: 282021888 18:01:30 INFO - PROCESS | 1680 | 18:01:32 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:01:33 INFO - PROCESS | 1680 | RSS: Main: 282271744 18:01:33 INFO - PROCESS | 1680 | 18:01:36 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:01:36 INFO - PROCESS | 1680 | RSS: Main: 282304512 18:01:36 INFO - PROCESS | 1680 | 18:01:39 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:01:40 INFO - PROCESS | 1680 | RSS: Main: 282693632 18:01:40 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 18:01:42 INFO - PROCESS | 1680 | RSS: Main: 283815936 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | __start_tp_report 18:01:42 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 18:01:42 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 18:01:42 INFO - PROCESS | 1680 | |i|pagename|runs| 18:01:42 INFO - PROCESS | 1680 | |0;ai-astar;103;117;108;117;117;116;113;116;118;122 18:01:42 INFO - PROCESS | 1680 | |1;audio-beat-detection;143;108;132;156;108;130;129;111;158;110 18:01:42 INFO - PROCESS | 1680 | |2;audio-dft;195;195;203;199;209;221;193;197;195;196 18:01:42 INFO - PROCESS | 1680 | |3;audio-fft;72;83;77;143;68;58;73;85;158;55 18:01:42 INFO - PROCESS | 1680 | |4;audio-oscillator;70;72;126;100;99;124;114;68;72;112 18:01:42 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;88;86;88;86;90;86;89;85;91;85 18:01:42 INFO - PROCESS | 1680 | |6;imaging-darkroom;94;94;119;149;95;143;97;90;149;150 18:01:42 INFO - PROCESS | 1680 | |7;imaging-desaturate;90;141;143;91;121;90;151;144;113;91 18:01:42 INFO - PROCESS | 1680 | |8;json-parse-financial;54;58;55;57;57;58;58;62;82;47 18:01:42 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;67;71;71;66;81;92;89;61;64;76 18:01:42 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;85;90;70;78;75;75;85;109;106;92 18:01:42 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;141;144;143;149;142;141;154;154;162;142 18:01:42 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;168;184;166;166;166;167;166;167;163;166 18:01:42 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;68;66;70;65;69;67;67;65;68;66 18:01:42 INFO - PROCESS | 1680 | __end_tp_report 18:01:42 INFO - PROCESS | 1680 | __start_cc_report 18:01:42 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1047 18:01:42 INFO - PROCESS | 1680 | __end_cc_report 18:01:42 INFO - PROCESS | 1680 | __startTimestamp1470618102280__endTimestamp 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | ------- Summary: start ------- 18:01:42 INFO - PROCESS | 1680 | Number of tests: 14 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:114.70 Median:117.00 stddev:5.46 (4.7%) stddev-sans-first:3.81 18:01:42 INFO - PROCESS | 1680 | Values: 103.0 117.0 108.0 117.0 117.0 116.0 113.0 116.0 118.0 122.0 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:131.00 stddev:19.27 (14.7%) stddev-sans-first:19.71 18:01:42 INFO - PROCESS | 1680 | Values: 143.0 108.0 132.0 156.0 108.0 130.0 129.0 111.0 158.0 110.0 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:200.30 Median:198.00 stddev:8.69 (4.4%) stddev-sans-first:9.01 18:01:42 INFO - PROCESS | 1680 | Values: 195.0 195.0 203.0 199.0 209.0 221.0 193.0 197.0 195.0 196.0 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:87.20 Median:72.50 stddev:34.87 (48.1%) stddev-sans-first:36.55 18:01:42 INFO - PROCESS | 1680 | Values: 72.0 83.0 77.0 143.0 68.0 58.0 73.0 85.0 158.0 55.0 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:69.00 stddev:23.33 (33.8%) stddev-sans-first:22.82 18:01:42 INFO - PROCESS | 1680 | Values: 70.0 72.0 126.0 100.0 99.0 124.0 114.0 68.0 72.0 112.0 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:2.12 (2.4%) stddev-sans-first:2.24 18:01:42 INFO - PROCESS | 1680 | Values: 88.0 86.0 88.0 86.0 90.0 86.0 89.0 85.0 91.0 85.0 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:118.00 Median:92.00 stddev:26.83 (29.2%) stddev-sans-first:27.01 18:01:42 INFO - PROCESS | 1680 | Values: 94.0 94.0 119.0 149.0 95.0 143.0 97.0 90.0 149.0 150.0 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:117.50 Median:120.50 stddev:25.77 (21.4%) stddev-sans-first:25.34 18:01:42 INFO - PROCESS | 1680 | Values: 90.0 141.0 143.0 91.0 121.0 90.0 151.0 144.0 113.0 91.0 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:58.00 stddev:9.03 (15.6%) stddev-sans-first:9.41 18:01:42 INFO - PROCESS | 1680 | Values: 54.0 58.0 55.0 57.0 57.0 58.0 58.0 62.0 82.0 47.0 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:73.50 stddev:10.55 (14.4%) stddev-sans-first:10.90 18:01:42 INFO - PROCESS | 1680 | Values: 67.0 71.0 71.0 66.0 81.0 92.0 89.0 61.0 64.0 76.0 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:81.50 stddev:13.09 (16.1%) stddev-sans-first:13.87 18:01:42 INFO - PROCESS | 1680 | Values: 85.0 90.0 70.0 78.0 75.0 75.0 85.0 109.0 106.0 92.0 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:147.20 Median:146.50 stddev:7.25 (5.0%) stddev-sans-first:7.34 18:01:42 INFO - PROCESS | 1680 | Values: 141.0 144.0 143.0 149.0 142.0 141.0 154.0 154.0 162.0 142.0 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:166.50 stddev:5.80 (3.5%) stddev-sans-first:6.15 18:01:42 INFO - PROCESS | 1680 | Values: 168.0 184.0 166.0 166.0 166.0 167.0 166.0 167.0 163.0 166.0 18:01:42 INFO - PROCESS | 1680 | 18:01:42 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.66 (2.5%) stddev-sans-first:1.73 18:01:42 INFO - PROCESS | 1680 | Values: 68.0 66.0 70.0 65.0 69.0 67.0 67.0 65.0 68.0 66.0 18:01:42 INFO - PROCESS | 1680 | -------- Summary: end -------- 18:01:42 INFO - PROCESS | 1680 | 18:01:43 INFO - TEST-INFO | 1680: exit 0 18:01:43 INFO - TEST-OK | kraken | took 59953ms 18:01:43 INFO - SUITE-END | took 1173s 18:01:43 INFO - Completed test suite (00:19:33) 18:01:43 INFO - javascript benchmark 18:01:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7484.2939095749625, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2894.9276268093304, 2979.4636965346235, 3368.6294507604175, 3370.2922386298874, 3380.205651671858, 4605.424321959755, 5535.750891209896, 5590.273264475618, 5595.132754423066, 5634.239377684022, 4673.556012178846, 5594.804181853636, 5610.382857885639, 5611.466910643492, 5622.4939755422, 5069.062223488648, 5133.383993920716, 5141.1003074462005, 5217.034848553029, 5238.895222095556, 4699.130660827758, 5094.261332106842, 5184.585233181355, 5214.191800270964, 5270.7628156733035, 5052.8484145475695, 5106.974465127688, 5140.588752899796, 5141.948580514184, 5151.253068305094, 5094.184930411154, 5144.871378215537, 5149.407818100892, 5182.740862956837, 5230.529252367267, 5069.518395752398, 5134.922976155361, 5149.716765577892, 5154.304168937183, 5163.380394352665, 5426.131818908955, 5436.510714035716, 5537.8061767838335, 5604.691741954191, 5612.438756124396, 6109.3890610939, 6138.770160990056, 6141.140240366352, 6156.969215153896, 6166.013437849922, 6165.537584681167, 6182.783602573933, 6196.690165491753, 6206.410391012847, 6222.0, 5599.076152434803, 5638.887222255532, 5695.145728140812, 5696.401877802854, 5842.18209450673, 6125.571210015256, 6138.0, 6152.600080994721, 6163.9383606163365, 6180.0, 5907.0, 6059.333473317932, 6061.909071363933, 6063.939360606426, 6081.209442772411, 6045.153678485016, 6046.818595442144, 6113.174721412553, 6138.294096178907, 6156.29202641693, 6069.3627169147485, 6100.611450805989, 6121.6358891611635, 6135.04893764628, 6148.678034222664, 6091.02543593023, 6099.536002066622, 6115.550245189573, 6124.341790330294, 6151.384861513902, 4735.857924262277, 4805.0, 4842.6368022398465, 4938.604911607063, 4945.9752701236985, 4370.060437006059, 4373.825046998148, 4404.07514421975, 4453.354263631755, 4494.438195225597, 4607.956490886824, 5551.916721249185, 5564.527015203753, 5570.08093664549, 5582.33012038558, 6006.309274433496, 6090.36051214625, 6116.174316467309, 6131.386861313833, 6154.446099851035, 5641.153826925912, 5685.260916080883, 5688.715564221772, 5698.971505142447, 5731.856703582361, 5389.67661940277, 5402.432744561843, 5403.108487099585, 5410.91883621746, 5420.159875219348, 6099.037411928083, 6140.846478837886, 6179.598326108789, 6202.751889924442, 6224.844378890564, 6130.141780150871, 6147.831911936718, 6156.322804491413, 6163.84590385244, 6209.844753881189, 6176.876462470816, 6185.134081228722, 6201.937980620136, 6206.286277078013, 6208.317085120543, 5105.28526006352, 5969.164316995711, 5992.340842507234, 6099.207103076572, 6121.816345509642, 6139.140520327069, 6142.7136481981925, 6144.723487443165, 6167.6916154193, 6180.81457556256, 5858.209141765807, 6030.7286172121485, 6032.215811944595, 6060.090986352083, 6087.208662873798, 5791.333996590278, 5878.941210587839, 5923.08192230205, 5953.987822070345, 6067.635941843503, 5488.56091512686, 5797.101449275369, 5825.825225243249, 5841.766329346779, 5855.619384739978, 6002.249718785152, 6003.129546215861, 6058.939410606014, 6084.513238940785, 6105.14527966094, 5855.180274761622, 5877.35349111606, 5882.1470886722045, 5907.940920590911, 5914.585978981602], "value": 5586.9338860513335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.5521564944601, 514.9974250128748, 526.8577484079298, 528.4345750047446, 538.1873371209473, 32314.353712925727, 41003.38494922575, 41010.0, 41071.17857642853, 41120.79439602805, 41312.38031429523, 41733.79133104338, 41779.373309400384, 41840.79079604605, 41956.37065444021, 9608.135267825877, 9849.310548261625, 9850.064243896853, 9850.655227067055, 9864.654737084204, 9743.610255589769, 9761.853572196424, 9841.0, 9843.212542996544, 9894.406335619886, 9842.753931151707, 9862.45756483393, 9864.112229899307, 9867.40795552269, 9884.209263258957, 9793.951030244874, 9795.167410770022, 9834.508274586278, 9864.013598640151, 9880.061394167542, 9591.760205994837, 9654.131128198425, 9664.95167524165, 9754.707358779247, 9763.707088787347, 39485.21029579392, 39702.60297397018, 39798.60201397978, 39853.40219896704, 39882.60117398818, 3108.782385233035, 3292.8682852685865, 3361.2605226850055, 3430.3310854383403, 4064.5935406459116, 31223.375532489223, 31472.685273147203, 31741.523877141863, 31992.840035799905, 32038.679613203803, 3196.4246435641576, 3216.4049650814673, 3219.1791093271067, 3234.56333394991, 3347.0460918638073, 511727.8827211755, 514735.0, 522828.0, 523591.0, 524444.0, 59702.0, 59916.0, 60041.39958600445, 60061.39938600558, 60123.09815352773, 34266.0, 35342.82328588392, 35677.46483802745, 62446.37553624497, 62993.370066298754, 14762.70474590502, 16305.02169869788, 16465.506034818976, 16500.75248871268, 16530.504084877473, 11492.540298388138, 11678.0, 11785.410729463492, 11834.585789497327, 11864.0, 16048.839511604969, 19390.0, 19439.930803805928, 19442.319518816774, 19481.415557533295, 8132.0, 8223.176223056307, 8237.752867413987, 8279.8344033119, 8323.958380208182, 899.5367385796189, 938.9154976052188, 950.805084957582, 984.5963155106372, 1017.9565944906531, 26683.33291667685, 29614.259643509085, 29914.40171196564, 30797.23006924845, 31208.687913121033, 1070.6520380876245, 1086.3481910853425, 1117.3296022386667, 1139.6182278936483, 1171.841801356806, 14452.988290819541, 15084.698306033817, 15307.311170997333, 15948.2823272953, 15958.9202053989, 677340.0, 685667.0, 687199.0, 687413.6887946685, 687909.0, 57979.71010144922, 59596.10605840916, 59670.70164649236, 59733.70133149307, 59846.70076649589, 1346.1721041559567, 1376.4700590272816, 1393.7212557488542, 1396.1762560089596, 1399.1185553101482, 30087.778933056346, 30255.0, 30519.38961220719, 30798.69201308048, 30911.536326954665, 50615.240771387726, 50672.74663626658, 50759.2386114216, 50964.49035509597, 51028.0, 602644.0, 606228.0, 608634.0, 612341.0, 612868.0, 26553.20423238202, 26724.797384117373, 26759.260648057814, 27115.59326610063, 27172.864135679196, 47871.28193077037, 48374.75812620914, 48594.514054859, 49647.25529116994, 49825.0, 39685.00787480336, 39754.80122599369, 40081.0, 40898.9775255621, 41284.79357603193, 39815.00462488461, 40012.99967500836, 40174.0, 40388.59611403966, 41445.171096577295, 33004.0, 33005.834970824995, 35816.0, 38836.029099272746, 39110.6088939107, 33854.8307258472, 34600.82699586486, 34716.0, 35035.824820875736, 35562.28875422529, 25679.972801087748, 25983.622129123094, 26090.73909260883, 26325.60511592366, 26590.335241619116], "value": 20101.45798489734, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.7854969193946, 353.9452431753375, 365.8628014494563, 390.96676782473486, 403.2902092317522, 19790.30733924313, 19821.603567928632, 20575.485612859688, 20590.89704551479, 20763.896180519114, 11967.46146423411, 12105.15263931525, 17657.0, 19710.0, 20808.68786968193, 5436.537894278991, 5629.662220266797, 5631.831045068655, 5639.984802735506, 5643.717814109299, 5734.254546908896, 6026.879462410771, 6096.695165241742, 6103.542234332421, 6113.755449782026, 5097.923531147036, 6040.818775436722, 6056.848578785522, 6108.786192483264, 6109.205803245572, 5322.2282768998475, 6064.151018857364, 6118.785842495514, 6161.7535298588, 6210.472109870644, 5894.440028197314, 5911.379305172938, 6031.4270144336215, 6032.155498230251, 6039.818805435844, 13002.0, 13212.471501139942, 13667.043306968517, 13840.792388114187, 13898.93050534751, 2158.3956492182056, 2184.2573525001417, 2235.832312576547, 2436.9634455483183, 3041.300500884809, 16843.32626694931, 16920.661586768318, 17054.317827286894, 17426.302947882068, 18313.450596482126, 1926.5280006398382, 1956.7847536770944, 2000.4398768344886, 2073.8340932725346, 2125.3836387447623, 119340.0, 142229.0, 142293.2885335577, 145858.0, 156701.0, 21284.403669724834, 21688.674669879965, 22075.448113797283, 22293.442663933532, 22331.761894525203, 35473.82263088668, 36261.45607815885, 36321.72873949399, 36336.0, 36407.0, 10597.41714205726, 10609.787804243872, 10991.945040274748, 11036.337819730841, 11173.664790056311, 8911.643534258686, 8998.820023599492, 9015.504147271962, 9142.3600347975, 9161.312901532412, 8100.554469504116, 9795.363301385387, 9891.406515608942, 9995.350302230332, 10051.095401413762, 3855.190410013872, 3883.514560679915, 3907.9218415631526, 3920.4903362562686, 3924.9803750981064, 870.3776799588325, 911.8221946720458, 961.8990006049404, 994.7065615643403, 1015.8730158730159, 21550.461238469165, 22303.44241393978, 22375.0, 22721.886390568274, 22889.771102288763, 903.3315346643568, 917.8944421391625, 939.9436033837992, 955.3121752338305, 959.2326139088701, 8975.192232698957, 10223.539940702687, 11337.43312834355, 11835.349055802013, 11893.583724569598, 538045.0, 599044.0, 600566.0, 602828.0, 618197.0, 71954.64022679852, 74804.62597686976, 110783.44608276906, 128015.0, 148092.25953870162, 972.7033254857195, 1002.4912506677404, 1004.0561871840447, 1011.2112552209288, 1020.9795804084025, 19521.0, 19976.800231997495, 20002.499937501678, 20108.69836952476, 20267.898660506602, 43597.69206923797, 47836.54084988331, 52675.47324526706, 57675.42324576701, 58632.82734345204, 72079.86854553645, 88735.66896496428, 88940.0, 89699.20601587801, 90758.0, 6920.238773734985, 8160.714374996846, 8255.174482551696, 8285.25432711059, 8508.936382952132, 9241.491717955578, 12762.87237127654, 13158.671033224246, 13404.463821447032, 13740.862591374358, 9512.906015807994, 11545.653630391102, 11751.471183796579, 11802.645920622395, 11852.822207667065, 9335.859962100438, 11562.76874462523, 11563.884361156617, 11587.42062896835, 11921.225120367148, 11544.59593914209, 11659.650210493699, 11880.168388213087, 11911.880881191424, 11984.820227696766, 7021.876499760014, 7130.786076417716, 8114.472559283628, 8127.918720812716, 8295.917040829514, 8335.708250211213, 10745.623903163352, 10995.890041099487, 11370.20408571392, 11828.0], "value": 10521.969268752839, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1511.9794138956206, 1550.4960887711495, 1737.4787563730886, 1794.111914602272, 1825.4614888607869, 8054.516728996265, 8376.832463350729, 8579.18497742715, 8861.202491775739, 8888.822223555526, 8172.795680107985, 8315.958420207891, 8680.826383472328, 8836.602352894119, 8839.955800221005, 2335.5912715274844, 2381.30942026812, 2385.129427758864, 2385.3082606044227, 2390.5577468168444, 2317.536492701458, 2350.459394339303, 2394.042383046778, 2396.4128788446856, 2397.6883005209384, 2354.5173239485866, 2370.182287110944, 2378.916737914173, 2397.1250493569896, 2403.483251101013, 2356.9528609427716, 2370.8577485350934, 2370.988145059281, 2376.3346263046374, 2377.63146712259, 2313.664518644804, 2333.404981729665, 2350.1656911796235, 2358.681577986967, 2358.8466749661216, 8896.8665470018, 8896.955515222448, 8941.46351218929, 8966.820663586757, 9019.278457723367, 5225.6603320784025, 5344.732763361816, 5349.277847490578, 5357.758900849432, 5358.812441564526, 3540.6990405815536, 3566.6076731559506, 3582.5521809773777, 3614.7469677122613, 3640.290143422034, 1072.9017927970774, 1075.2473268711933, 1082.577794660083, 1087.152021423291, 1092.9344239345664, 11351.943240283828, 11440.656780296604, 11507.309561426258, 11535.596254131066, 11587.478563464665, 4484.080763443486, 4578.221702310615, 4701.130290896127, 4722.079194557028, 4733.455652599995, 9907.25695572835, 9980.401175929468, 10003.399796012263, 10008.299419040597, 10013.148882345082, 5169.612279079084, 5183.352080989876, 5226.425093239741, 5227.686338819683, 5254.369475662945, 4359.476862776487, 4715.104130215317, 4812.422509298836, 4823.589994850407, 4864.683795553277, 3812.4853144825092, 3937.5668676445566, 3983.402489626579, 3992.441058251847, 4050.2709512287483, 1123.7246874515795, 1222.9816552751715, 1273.7898246789362, 1284.4862055178003, 1289.8645642207432, 923.1414784250711, 939.5537119868145, 940.6660635474445, 945.4043952310001, 987.683941138843, 5241.764120614582, 5984.461398474158, 6080.0, 6090.847728806727, 6224.937750622526, 881.6517475597232, 899.2536194958169, 955.7515046088067, 975.2831668723625, 1005.4319309590204, 3955.3078211312904, 4067.7355971861734, 4118.238125946709, 4185.204811085884, 4222.0500387412585, 10286.434246116385, 10791.460426978776, 10792.028717415471, 10798.082163016075, 10800.08199303068, 10706.411147386969, 10715.624953126604, 10720.839187412195, 10747.838782418114, 10759.677209683721, 7774.533527988338, 8018.679252829821, 8201.917980820235, 8210.83578328442, 8314.875276870851, 5917.526597872074, 5935.792247271324, 6068.302145253352, 6081.483073938764, 6128.448439640454, 9581.568829402555, 9807.06832850878, 9815.067568580973, 9820.65627703027, 9846.803063938538, 9474.38416502925, 9906.009399060325, 9922.950385248028, 9941.602335906482, 9997.850032249376, 7037.049998250375, 7351.3751331137455, 7469.402447804054, 7475.401967842451, 7632.0, 8365.581720913808, 8367.037790653909, 8429.199226073513, 8435.156484351515, 8439.70461033861, 7378.520396174232, 7393.815154620962, 7590.278923502258, 7659.923400765921, 7680.462367634212, 7335.7432489862595, 7461.95532625422, 7475.588842613708, 7570.394368450621, 7654.119776225805, 6987.161540615159, 7116.217216106121, 7117.39502142303, 7135.42916566663, 7142.035825163744, 4965.3296804932315, 4982.501749824988, 5081.18701007837, 5096.159133742891, 5135.614828887774, 4979.103761322852, 5040.470750571138, 5153.123968925217, 5153.819616313411, 5254.13306804373], "value": 4617.338329953072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.23694578824006, 308.48791006928496, 314.61931063413266, 315.9810411375317, 318.02683787609914, 4715.976420117895, 5527.0, 5595.608307418483, 5728.856778580537, 5765.250517432738, 5514.531264842483, 5567.325565127017, 5569.136783798507, 5582.7766889324375, 5603.719814009293, 3961.742486738353, 3974.8671628585857, 4110.609492098246, 4280.566010386524, 4301.440812694345, 3991.6207960243732, 4141.337386018237, 4255.616994470497, 4278.679099067583, 4331.7617531035785, 3572.9821350893208, 3834.9424758628643, 3856.3251430999603, 4222.746635201897, 4223.387608796723, 3196.922000699564, 3326.7338612910908, 3732.2348918471785, 4057.7623824733446, 4090.570490098556, 3197.289450144185, 3616.674499295076, 3694.9815250923843, 3696.464012718141, 3720.2373513429684, 5328.147496400596, 5377.091132647893, 5410.323709536308, 5414.3232095988005, 5432.674039557639, 4906.0, 4906.705597664116, 4909.828156014558, 4925.261210818406, 4938.728369939688, 5603.691796951166, 5920.911186332209, 5949.345571987078, 5952.529700174466, 5992.730327135289, 3950.012496875781, 4011.478507793968, 4033.757974521509, 4067.0, 4067.28822456069, 5447.509724124809, 6244.470104824301, 6265.8120256392385, 6322.020086886586, 6335.271443783978, 3483.397637086968, 3928.2339943710704, 4105.261053010427, 4119.670426365884, 4140.37894315855, 3625.492431059654, 3826.5408151022057, 4093.9385909211387, 4113.506379234451, 4115.7324773890205, 4432.800523976429, 4803.423589169322, 4817.421909370828, 4837.685550439211, 4854.732989685601, 5244.895102098013, 5944.256967879015, 5983.65367792252, 5984.132300816357, 6024.258962172201, 1310.6461255460972, 1338.3642769684323, 1366.9726605467836, 1375.5735721926235, 1403.4316101978511, 771.9768406947801, 780.2392667149597, 820.5035953248199, 829.3531045784177, 864.5158711121666, 4417.359482874966, 4591.028760122536, 4619.884502887455, 4635.513271106553, 4672.719636821734, 5098.490150984946, 5099.6685215460875, 5104.464031276737, 5108.923366149511, 5140.151874940668, 4417.6431398675695, 4605.332226827091, 4637.39713837199, 4692.929606055912, 4701.318308845198, 2301.4821665125546, 2521.4704911968693, 2605.960910586343, 2680.852553109559, 2694.851783151906, 4486.887827804266, 4771.642126840501, 5212.9052898890895, 5271.42014378418, 5279.973600131974, 4754.95245047552, 5031.622628302892, 5253.317068781034, 5268.525832675077, 5277.366715994105, 5678.886422271614, 6326.41839540115, 6383.329750376237, 6424.691283988843, 6435.678216089177, 5048.671836330626, 6220.315765265726, 6257.342978987323, 6266.310705822265, 6313.621182729051, 5077.0, 5097.898042039213, 5764.567657425626, 6125.938740612537, 6178.505719542336, 5294.179402192666, 5520.779168833363, 6144.477719393902, 6229.595076320024, 6388.584741991755, 3679.889603311905, 3840.7695538267794, 3926.941095883621, 3996.6802655788047, 4092.549819519791, 5098.643094983316, 5376.946230537801, 6051.5461340400525, 6094.39056094387, 6104.0, 5953.345132035386, 5974.0, 6007.219061521974, 6016.789412370546, 6042.305134909541, 5382.30030096085, 5630.211770352236, 5769.0, 5905.911411328748, 5911.615744976562, 5831.94168058314, 5849.64902105875, 5863.768608592243, 5873.765049397976, 5885.176075349369, 5401.595585147811, 5412.025835349675, 5935.527716286021, 5975.820725378246, 5984.551158663031, 5164.664296820694, 5767.106098554731, 5912.688894219251, 5974.850628734316, 5977.790777322947], "value": 4169.38837795036, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.6227712481011, 759.4683721395024, 777.3431450424397, 814.9470284431512, 843.4915377308286, 14699.779503307445, 15031.549053528384, 15193.544193674179, 15208.847911520881, 15211.847881521182, 14187.219702916336, 14222.217778022205, 14255.3585088671, 14336.068155569881, 14369.78445323321, 688.8656711941173, 857.4041041476177, 880.7225723896952, 883.2492381475759, 885.3846576629245, 851.9148085191463, 860.8837806896083, 877.8990416102134, 888.1473785166248, 888.3293113699148, 906.7914379692675, 934.3739694404765, 938.6057855700589, 939.9201067909202, 942.3309450290268, 922.4511415707643, 933.6638810028385, 934.6168071090854, 935.0976307862911, 935.6023689931752, 693.8855088910324, 695.9652017399161, 695.9721611135549, 697.2817997462571, 697.8360085379932, 14622.195779232137, 14663.193524356157, 14924.552263432115, 14958.476453324081, 14983.925080374638, 13032.348382580927, 14630.0, 14706.705865882623, 14856.554303370916, 14902.627434314121, 11907.345096019715, 11990.0, 12083.0, 12086.0, 12207.511699532097, 3871.7870517121546, 3877.3408520551293, 3902.5902280260448, 3939.9212015759813, 4044.0, 112952.0, 115060.0, 119914.35540519723, 122093.77906221001, 122915.38542307321, 10311.329763565343, 10484.580616775243, 10743.355398676105, 10844.024037836632, 10990.835137472945, 21105.57788844245, 21368.358949231548, 21576.029078691496, 21601.78398216029, 21647.891760541097, 7701.345385642171, 7718.53688778675, 7729.420293478011, 7803.141654418009, 7888.092869319987, 4373.584509471595, 4397.912041759147, 4416.7593474606565, 4459.420275364182, 4532.88667783308, 3463.6882680558365, 3546.5212196353164, 3553.626869178751, 3591.7665351752053, 3595.5146055282726, 616.5868867858545, 641.7588947485757, 653.4543656047159, 655.6885479397248, 656.1830521001289, 604.7792555717132, 607.3380015782818, 632.3423639414957, 635.9459445947147, 639.6354078175395, 9019.323550733721, 9201.263898888074, 9233.815323693489, 9241.013182165867, 9277.67528136512, 493.7580585513073, 499.807574083973, 596.3648714119449, 645.2482857471088, 648.8799572079181, 3825.483559719458, 3849.034517308262, 4430.180416622935, 4558.635309175258, 4624.075184963021, 169245.0, 174425.0, 174676.0, 176592.93628254725, 181943.09028454774, 131491.34254328857, 134468.0, 137072.0577099359, 139310.99999999796, 139660.0, 106140.0, 122476.38761806134, 124551.0, 124850.0, 129283.35358323336, 8270.793230169294, 8662.956685216786, 8674.436161649473, 8777.692780752643, 8793.160764700368, 66170.66914665588, 68747.65626171837, 70216.29783702303, 71066.64466677634, 72946.0, 84996.57501712452, 92435.0, 106129.0, 107741.46129269303, 107777.46111269394, 11184.88815111871, 11315.547378104784, 11315.660530184108, 11517.942410287895, 11638.607913615078, 10952.39761813076, 12379.257244565355, 12405.317707525812, 12417.62747117588, 12581.622551323475, 11650.70873228176, 11993.76012479728, 12121.515139394325, 12261.534332097262, 12285.463399057991, 11677.017393214355, 11931.164818462625, 11957.282563046245, 12111.091668125102, 12336.691582710504, 11647.825282620597, 11887.405629718653, 12060.396980151132, 12277.20198187115, 12317.384130793604, 9720.659776908056, 9856.408615483095, 9986.251031172837, 10301.587936482756, 10404.583816647551, 8533.658653653783, 9107.453552786854, 9741.220702343653, 10032.548535315782, 10201.0], "value": 7724.954998645953, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 108.0, 117.0, 117.0, 116.0, 113.0, 116.0, 118.0, 122.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 132.0, 156.0, 108.0, 130.0, 129.0, 111.0, 158.0, 110.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 195.0, 203.0, 199.0, 209.0, 221.0, 193.0, 197.0, 195.0, 196.0], "value": 200.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 83.0, 77.0, 143.0, 68.0, 58.0, 73.0, 85.0, 158.0, 55.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 126.0, 100.0, 99.0, 124.0, 114.0, 68.0, 72.0, 112.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 90.0, 86.0, 89.0, 85.0, 91.0, 85.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 119.0, 149.0, 95.0, 143.0, 97.0, 90.0, 149.0, 150.0], "value": 118.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 141.0, 143.0, 91.0, 121.0, 90.0, 151.0, 144.0, 113.0, 91.0], "value": 117.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 55.0, 57.0, 57.0, 58.0, 58.0, 62.0, 82.0, 47.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 71.0, 66.0, 81.0, 92.0, 89.0, 61.0, 64.0, 76.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 70.0, 78.0, 75.0, 75.0, 85.0, 109.0, 106.0, 92.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 144.0, 143.0, 149.0, 142.0, 141.0, 154.0, 154.0, 162.0, 142.0], "value": 147.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 184.0, 166.0, 166.0, 166.0, 167.0, 166.0, 167.0, 163.0, 166.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 70.0, 65.0, 69.0, 67.0, 67.0, 65.0, 68.0, 66.0], "value": 67.1, "unit": "score"}]}]} 18:01:43 INFO - Return code: 0 18:01:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:01:43 ERROR - # TBPL SUCCESS # 18:01:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:01:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:01:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:01:43 INFO - 2016-08-07 18:01:43.622 screenresolution[1685:11354] starting screenresolution argv=screenresolution get 18:01:43 INFO - 2016-08-07 18:01:43.625 screenresolution[1685:11354] Display 0: 1600x1200x32@60 18:01:43 INFO - 2016-08-07 18:01:43.630 screenresolution[1686:11357] starting screenresolution argv=screenresolution list 18:01:43 INFO - Available Modes on Display 0 18:01:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:01:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:01:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:01:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:01:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:01:43 INFO - Intel Iris: 18:01:43 INFO - Chipset Model: Intel Iris 18:01:43 INFO - Type: GPU 18:01:43 INFO - Bus: Built-In 18:01:43 INFO - VRAM (Dynamic, Max): 1536 MB 18:01:43 INFO - Vendor: Intel (0x8086) 18:01:43 INFO - Device ID: 0x0a2e 18:01:43 INFO - Revision ID: 0x0009 18:01:43 INFO - Displays: 18:01:43 INFO - Display: 18:01:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:01:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:01:43 INFO - Display Serial Number: 1600x1200 60 18:01:43 INFO - Main Display: Yes 18:01:43 INFO - Mirror: Off 18:01:43 INFO - Online: Yes 18:01:43 INFO - Rotation: Supported 18:01:43 INFO - Return code: 0 18:01:43 INFO - Running post-action listener: _resource_record_post_action 18:01:43 INFO - [mozharness: 2016-08-08 01:01:43.865274Z] Finished run-tests step (success) 18:01:43 INFO - Running post-run listener: _resource_record_post_run 18:01:43 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 31820800; Write bytes: 707206144; Read time: 196; Write time: 2028 18:01:43 INFO - TinderboxPrint: CPU usage
54.4% 18:01:43 INFO - TinderboxPrint: I/O read bytes / time
31,820,800 / 196 18:01:43 INFO - TinderboxPrint: I/O write bytes / time
707,206,144 / 2,028 18:01:43 INFO - TinderboxPrint: CPU idle
2,202.2 (45.6%) 18:01:43 INFO - TinderboxPrint: CPU system
970.5 (20.1%) 18:01:43 INFO - TinderboxPrint: CPU user
1,661.0 (34.4%) 18:01:43 INFO - TinderboxPrint: Swap in / out
435,150,848 / 0 18:01:43 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400482816; Write bytes: 393943040; Read time: 29785; Write time: 844 18:01:43 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 29854720; Write bytes: 297522176; Read time: 179; Write time: 1142 18:01:44 INFO - Running post-run listener: _upload_blobber_files 18:01:44 INFO - Blob upload gear active. 18:01:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:01:44 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 18:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:01:44 INFO - (blobuploader) - INFO - Open directory for files ... 18:01:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:01:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:01:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:45 INFO - (blobuploader) - INFO - Done attempting. 18:01:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:01:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:01:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:46 INFO - (blobuploader) - INFO - Done attempting. 18:01:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:01:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:01:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:49 INFO - (blobuploader) - INFO - Done attempting. 18:01:49 INFO - (blobuploader) - INFO - Iteration through files over. 18:01:49 INFO - Return code: 0 18:01:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:01:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:01:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27353ea6c4618de006c435e1f6efe6abd2e36d42b618b073c25b735ede419ff4088873e153b1184345f7be358fd690fc9dbc2725ea45ce3597bc5f52c9caaeb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6d6b3354aec74c97d234976480f1b910a0f9e4a44fedf56c60429c20edf8de2a1ec9afbea00cc7bf059bc4f2c9d166aec2370cbeb0b5e9b1c1beb37344a45a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00ee56f434a562987b2df1b97eb991f481245d21502ab3875b59056a80d1a8059c4bcead27b559f02118e3a886d42486aaa2c4334a5af6a64cd3e29478ab45ae"} 18:01:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:01:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:01:49 INFO - Contents: 18:01:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27353ea6c4618de006c435e1f6efe6abd2e36d42b618b073c25b735ede419ff4088873e153b1184345f7be358fd690fc9dbc2725ea45ce3597bc5f52c9caaeb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6d6b3354aec74c97d234976480f1b910a0f9e4a44fedf56c60429c20edf8de2a1ec9afbea00cc7bf059bc4f2c9d166aec2370cbeb0b5e9b1c1beb37344a45a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00ee56f434a562987b2df1b97eb991f481245d21502ab3875b59056a80d1a8059c4bcead27b559f02118e3a886d42486aaa2c4334a5af6a64cd3e29478ab45ae"} 18:01:49 INFO - Running post-run listener: copy_logs_to_upload_dir 18:01:49 INFO - Copying logs to upload dir... 18:01:49 INFO - mkdir: /builds/slave/test/build/upload/logs 18:01:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.449988 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-07 18:01:49.142756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 18:01:49.146265) ========= 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.iv0lE1QZz8/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.YYan4fEvJP/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27353ea6c4618de006c435e1f6efe6abd2e36d42b618b073c25b735ede419ff4088873e153b1184345f7be358fd690fc9dbc2725ea45ce3597bc5f52c9caaeb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6d6b3354aec74c97d234976480f1b910a0f9e4a44fedf56c60429c20edf8de2a1ec9afbea00cc7bf059bc4f2c9d166aec2370cbeb0b5e9b1c1beb37344a45a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00ee56f434a562987b2df1b97eb991f481245d21502ab3875b59056a80d1a8059c4bcead27b559f02118e3a886d42486aaa2c4334a5af6a64cd3e29478ab45ae"} build_url:https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/RNDS09HaRFOeLrJJR1_wLw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27353ea6c4618de006c435e1f6efe6abd2e36d42b618b073c25b735ede419ff4088873e153b1184345f7be358fd690fc9dbc2725ea45ce3597bc5f52c9caaeb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6d6b3354aec74c97d234976480f1b910a0f9e4a44fedf56c60429c20edf8de2a1ec9afbea00cc7bf059bc4f2c9d166aec2370cbeb0b5e9b1c1beb37344a45a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00ee56f434a562987b2df1b97eb991f481245d21502ab3875b59056a80d1a8059c4bcead27b559f02118e3a886d42486aaa2c4334a5af6a64cd3e29478ab45ae"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 18:01:49.182244) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 18:01:49.182783) ========= 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.iv0lE1QZz8/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.YYan4fEvJP/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.005094 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 18:01:49.233824) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 18:01:49.234324) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 18:01:49.234858) ========= ========= Total master_lag: 0.21 =========