builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0268 starttime: 1469104443.28 results: success (0) buildid: 20160721030216 builduid: baf5ae8238104ef689a1a3626b02ab35 revision: d224fc999cb6accb208af0a105f14433375e2e77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:03.284567) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:03.285022) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:03.285298) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:03.309761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:03.310056) ========= 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.QuBHBMYjED/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.ENvz94MB77/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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-07-21 05:34:03-- 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% 165M=0s 2016-07-21 05:34:03 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.609692 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:03.942421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:03.942776) ========= 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.QuBHBMYjED/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.ENvz94MB77/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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.039777 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:04.004710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 05:34:04.005265) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d224fc999cb6accb208af0a105f14433375e2e77 --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 d224fc999cb6accb208af0a105f14433375e2e77 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QuBHBMYjED/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.ENvz94MB77/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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-07-21 05:34:04,088 truncating revision to first 12 chars 2016-07-21 05:34:04,089 Setting DEBUG logging. 2016-07-21 05:34:04,089 attempt 1/10 2016-07-21 05:34:04,089 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d224fc999cb6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 05:34:05,195 unpacking tar archive at: mozilla-central-d224fc999cb6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.381184 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 05:34:05.409434) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:05.409767) ========= script_repo_revision: d224fc999cb6accb208af0a105f14433375e2e77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:05.410224) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:05.410507) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:05.429319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-07-21 05:34:05.429720) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.QuBHBMYjED/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.ENvz94MB77/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 05:34:05 INFO - MultiFileLogger online at 20160721 05:34:05 in /builds/slave/test 05:34:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:34:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:34:05 INFO - {'append_to_log': False, 05:34:05 INFO - 'base_work_dir': '/builds/slave/test', 05:34:05 INFO - 'blob_upload_branch': 'Firefox', 05:34:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:34:05 INFO - 'branch': 'Firefox', 05:34:05 INFO - 'buildbot_json_path': 'buildprops.json', 05:34:05 INFO - 'config_files': ('talos/mac_config.py',), 05:34:05 INFO - 'default_actions': ('clobber', 05:34:05 INFO - 'read-buildbot-config', 05:34:05 INFO - 'download-and-extract', 05:34:05 INFO - 'populate-webroot', 05:34:05 INFO - 'create-virtualenv', 05:34:05 INFO - 'install', 05:34:05 INFO - 'run-tests'), 05:34:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:34:05 INFO - 'download_minidump_stackwalk': True, 05:34:05 INFO - 'download_symbols': 'ondemand', 05:34:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:34:05 INFO - 'tooltool.py': '/tools/tooltool.py', 05:34:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:34:05 INFO - '/tools/misc-python/virtualenv.py')}, 05:34:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:34:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:34:05 INFO - 'installer_path': 'installer.exe', 05:34:05 INFO - 'log_level': 'info', 05:34:05 INFO - 'log_name': 'talos', 05:34:05 INFO - 'log_to_console': True, 05:34:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:34:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:34:05 INFO - 'opt_config_files': (), 05:34:05 INFO - 'pip_index': False, 05:34:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:34:05 INFO - 'cmd': ('bash', 05:34:05 INFO - '-c', 05:34:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:34:05 INFO - 'enabled': True, 05:34:05 INFO - 'halt_on_failure': False, 05:34:05 INFO - 'name': 'check_screen_resolution'},), 05:34:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:34:05 INFO - 'cmd': ('bash', 05:34:05 INFO - '-c', 05:34:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:34:05 INFO - 'enabled': True, 05:34:05 INFO - 'halt_on_failure': False, 05:34:05 INFO - 'name': 'check_screen_resolution'},), 05:34:05 INFO - 'run_cmd_checks_enabled': True, 05:34:05 INFO - 'sps_profile': False, 05:34:05 INFO - 'sps_profile_interval': 0, 05:34:05 INFO - 'suite': 'dromaeojs', 05:34:05 INFO - 'system_bits': '32', 05:34:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:34:05 INFO - 'title': 't-yosemite-r7-0268', 05:34:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:34:05 INFO - 'use_talos_json': True, 05:34:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:34:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:34:05 INFO - 'work_dir': 'build'} 05:34:05 INFO - [mozharness: 2016-07-21 12:34:05.632591Z] Running clobber step. 05:34:05 INFO - Running pre-action listener: _resource_record_pre_action 05:34:05 INFO - Running main action method: clobber 05:34:05 INFO - rmtree: /builds/slave/test/build 05:34:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:34:07 INFO - Running post-action listener: _resource_record_post_action 05:34:07 INFO - [mozharness: 2016-07-21 12:34:07.791264Z] Finished clobber step (success) 05:34:07 INFO - [mozharness: 2016-07-21 12:34:07.791419Z] Running read-buildbot-config step. 05:34:07 INFO - Running pre-action listener: _resource_record_pre_action 05:34:07 INFO - Running main action method: read_buildbot_config 05:34:07 INFO - Using buildbot properties: 05:34:07 INFO - { 05:34:07 INFO - "project": "", 05:34:07 INFO - "product": "firefox", 05:34:07 INFO - "script_repo_revision": "production", 05:34:07 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:34:07 INFO - "repository": "", 05:34:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:34:07 INFO - "buildid": "20160721030216", 05:34:07 INFO - "stage_platform": "macosx64", 05:34:07 INFO - "basedir": "/builds/slave/test", 05:34:07 INFO - "nightly_build": "True", 05:34:07 INFO - "buildnumber": 2, 05:34:07 INFO - "slavename": "t-yosemite-r7-0268", 05:34:07 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:34:07 INFO - "platform": "yosemite_r7", 05:34:07 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:34:07 INFO - "branch": "mozilla-central", 05:34:07 INFO - "repo_path": "mozilla-central", 05:34:07 INFO - "revision": "d224fc999cb6accb208af0a105f14433375e2e77", 05:34:07 INFO - "pgo_build": "False", 05:34:07 INFO - "builduid": "baf5ae8238104ef689a1a3626b02ab35", 05:34:07 INFO - "slavebuilddir": "test" 05:34:07 INFO - } 05:34:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 05:34:07 INFO - Running post-action listener: _resource_record_post_action 05:34:07 INFO - [mozharness: 2016-07-21 12:34:07.794856Z] Finished read-buildbot-config step (success) 05:34:07 INFO - [mozharness: 2016-07-21 12:34:07.794987Z] Running download-and-extract step. 05:34:07 INFO - Running pre-action listener: _resource_record_pre_action 05:34:07 INFO - Running main action method: download_and_extract 05:34:07 INFO - mkdir: /builds/slave/test/build/tests 05:34: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:07 INFO - https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:34:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:34:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:34:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 05:34:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 05:34:29 INFO - Downloaded 1199 bytes. 05:34:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 05:34:29 INFO - Using the following test package requirements: 05:34:29 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:34:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:34:29 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 05:34:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:34:29 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 05:34:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:34:29 INFO - u'jsshell-mac.zip'], 05:34:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:34:29 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 05:34:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:34:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:34:29 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 05:34:29 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:34:29 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 05:34:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:34:29 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 05:34:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:34:29 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 05:34:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:34:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:29 INFO - https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:34:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:34:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:34:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:34:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:34:33 INFO - Downloaded 18843089 bytes. 05:34:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:34:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:34:36 INFO - Return code: 0 05:34:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:34:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:36 INFO - https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:34:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:34:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:34:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:34:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:34:39 INFO - Downloaded 18843089 bytes. 05:34:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:34:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:34:43 INFO - Return code: 0 05:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:43 INFO - https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:34:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:34:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:34:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:34:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:34:44 INFO - Downloaded 14403317 bytes. 05:34:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:34:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:34:44 INFO - Return code: 0 05:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:44 INFO - https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:34:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:34:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:34:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 05:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 05:34:47 INFO - Downloaded 113052100 bytes. 05:34:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:34:47 INFO - mkdir: /builds/slave/test/properties 05:34:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:34:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:34:47 INFO - Contents: 05:34:47 INFO - build_url:https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:34:48 INFO - Running post-action listener: _resource_record_post_action 05:34:48 INFO - Running post-action listener: set_extra_try_arguments 05:34:48 INFO - [mozharness: 2016-07-21 12:34:48.900616Z] Finished download-and-extract step (success) 05:34:48 INFO - [mozharness: 2016-07-21 12:34:48.900749Z] Running populate-webroot step. 05:34:48 INFO - Running pre-action listener: _resource_record_pre_action 05:34:48 INFO - Running main action method: populate_webroot 05:34:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:34:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:34:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:34:48 INFO - '--tppagecycles', 05:34:48 INFO - '7'], 05:34:48 INFO - 'tests': ['tsvgm']}}, 05:34:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:34:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:34:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:34:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:34:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:34:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:34:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:48 INFO - 'talos_options': ['--disable-e10s'], 05:34:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:34:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:34:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:48 INFO - 'talos_options': ['--disable-e10s'], 05:34:48 INFO - 'tests': ['damp', 'tps']}, 05:34:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:48 INFO - 'tests': ['damp', 'tps']}, 05:34:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:34:48 INFO - 'tests': ['dromaeo_dom']}, 05:34:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:34:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:34:48 INFO - 'tests': ['basic_compositor_video']}, 05:34:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:34:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:34:48 INFO - 'tests': ['a11yr', 05:34:48 INFO - 'ts_paint', 05:34:48 INFO - 'tpaint', 05:34:48 INFO - 'sessionrestore', 05:34:48 INFO - 'sessionrestore_no_auto_restore', 05:34:48 INFO - 'tabpaint']}, 05:34:48 INFO - 'other-e10s': {'tests': ['a11yr', 05:34:48 INFO - 'ts_paint', 05:34:48 INFO - 'tpaint', 05:34:48 INFO - 'sessionrestore', 05:34:48 INFO - 'sessionrestore_no_auto_restore', 05:34:48 INFO - 'tabpaint']}, 05:34:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:34:48 INFO - 'ts_paint', 05:34:48 INFO - 'tpaint', 05:34:48 INFO - 'sessionrestore', 05:34:48 INFO - 'sessionrestore_no_auto_restore', 05:34:48 INFO - 'tabpaint']}, 05:34:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:34:48 INFO - 'ts_paint', 05:34:48 INFO - 'tpaint', 05:34:48 INFO - 'sessionrestore', 05:34:48 INFO - 'sessionrestore_no_auto_restore', 05:34:48 INFO - 'tabpaint']}, 05:34:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:34:48 INFO - 'tests': ['a11yr', 05:34:48 INFO - 'ts_paint', 05:34:48 INFO - 'tpaint', 05:34:48 INFO - 'sessionrestore', 05:34:48 INFO - 'sessionrestore_no_auto_restore', 05:34:48 INFO - 'tabpaint']}, 05:34:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:34:48 INFO - 'tests': ['a11yr', 05:34:48 INFO - 'ts_paint', 05:34:48 INFO - 'tpaint', 05:34:48 INFO - 'sessionrestore', 05:34:48 INFO - 'sessionrestore_no_auto_restore', 05:34:48 INFO - 'tabpaint']}, 05:34:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:34:48 INFO - 'tests': ['tsvgx', 05:34:48 INFO - 'tsvgr_opacity', 05:34:48 INFO - 'tart', 05:34:48 INFO - 'tscrollx', 05:34:48 INFO - 'cart']}, 05:34:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:34:48 INFO - 'tsvgr_opacity', 05:34:48 INFO - 'tart', 05:34:48 INFO - 'tscrollx', 05:34:48 INFO - 'cart']}, 05:34:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:48 INFO - 'talos_options': ['--disable-e10s'], 05:34:48 INFO - 'tests': ['tp5o']}, 05:34:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:48 INFO - 'tests': ['tp5o']}, 05:34:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:48 INFO - 'talos_options': ['--disable-e10s', 05:34:48 INFO - '--xperf_path', 05:34:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:34:48 INFO - 'tests': ['tp5n']}, 05:34:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:48 INFO - 'talos_options': ['--xperf_path', 05:34:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:34:48 INFO - 'tests': ['tp5n']}}, 05:34:48 INFO - 'talos.zip': {'path': '', 05:34:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:34:48 INFO - Running post-action listener: _resource_record_post_action 05:34:48 INFO - [mozharness: 2016-07-21 12:34:48.919494Z] Finished populate-webroot step (success) 05:34:48 INFO - [mozharness: 2016-07-21 12:34:48.919601Z] Running create-virtualenv step. 05:34:48 INFO - Running pre-action listener: _resource_record_pre_action 05:34:48 INFO - Running main action method: create_virtualenv 05:34:48 INFO - Creating virtualenv /builds/slave/test/build/venv 05:34:48 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 05:34:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:34:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:34:49 INFO - Using real prefix '/tools/python27' 05:34:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:34:49 INFO - Installing distribute.............................................................................................................................................................................................done. 05:34:52 INFO - Installing pip.................done. 05:34:52 INFO - Return code: 0 05:34:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:34:52 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:52 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:52 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 0x10426ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0b599270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d2d30>, '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 0x103f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041cab20>, '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.QuBHBMYjED/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.ENvz94MB77/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 05:34:52 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 05:34:52 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 05:34:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuBHBMYjED/Render', 05:34:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:34:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:34:52 INFO - 'HOME': '/Users/cltbld', 05:34:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:34:52 INFO - 'LOGNAME': 'cltbld', 05:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:52 INFO - 'MOZ_NO_REMOTE': '1', 05:34:52 INFO - 'NO_EM_RESTART': '1', 05:34:52 INFO - 'PAGER': '/bin/cat', 05:34:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:52 INFO - 'PWD': '/builds/slave/test', 05:34:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:34:52 INFO - 'SHELL': '/bin/bash', 05:34:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ENvz94MB77/Listeners', 05:34:52 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 05:34:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:34:52 INFO - 'USER': 'cltbld', 05:34:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:34:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:52 INFO - 'XPC_FLAGS': '0x0', 05:34:52 INFO - 'XPC_SERVICE_NAME': '0', 05:34:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:52 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 05:34:52 INFO - Cleaning up... 05:34:52 INFO - Return code: 0 05:34:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:34:52 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:52 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:52 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 0x10426ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0b599270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d2d30>, '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 0x103f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041cab20>, '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.QuBHBMYjED/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.ENvz94MB77/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 05:34:52 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 05:34:52 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 05:34:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuBHBMYjED/Render', 05:34:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:34:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:34:52 INFO - 'HOME': '/Users/cltbld', 05:34:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:34:52 INFO - 'LOGNAME': 'cltbld', 05:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:52 INFO - 'MOZ_NO_REMOTE': '1', 05:34:52 INFO - 'NO_EM_RESTART': '1', 05:34:52 INFO - 'PAGER': '/bin/cat', 05:34:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:52 INFO - 'PWD': '/builds/slave/test', 05:34:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:34:52 INFO - 'SHELL': '/bin/bash', 05:34:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ENvz94MB77/Listeners', 05:34:52 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 05:34:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:34:52 INFO - 'USER': 'cltbld', 05:34:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:34:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:52 INFO - 'XPC_FLAGS': '0x0', 05:34:52 INFO - 'XPC_SERVICE_NAME': '0', 05:34:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:53 INFO - Downloading/unpacking psutil>=3.1.1 05:34:53 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 05:34:53 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 05:34:53 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 05:34:53 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 05:34:53 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 05:34:53 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 05:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:34:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:34:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:34:56 INFO - Installing collected packages: psutil 05:34:56 INFO - Running setup.py install for psutil 05:34:56 INFO - building 'psutil._psutil_osx' extension 05:34:56 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 05:34:57 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 05:34:57 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 05:34:57 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 05:34:57 INFO - building 'psutil._psutil_posix' extension 05:34:57 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 05:34:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:34:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:34:57 INFO - ^ 05:34:57 INFO - 1 warning generated. 05:34:57 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 05:34:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:34:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:34:57 INFO - Successfully installed psutil 05:34:57 INFO - Cleaning up... 05:34:57 INFO - Return code: 0 05:34:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:34:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:57 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 0x10426ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0b599270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d2d30>, '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 0x103f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041cab20>, '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.QuBHBMYjED/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.ENvz94MB77/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 05:34:57 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 05:34:57 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 05:34:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuBHBMYjED/Render', 05:34:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:34:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:34:57 INFO - 'HOME': '/Users/cltbld', 05:34:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:34:57 INFO - 'LOGNAME': 'cltbld', 05:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:57 INFO - 'MOZ_NO_REMOTE': '1', 05:34:57 INFO - 'NO_EM_RESTART': '1', 05:34:57 INFO - 'PAGER': '/bin/cat', 05:34:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:57 INFO - 'PWD': '/builds/slave/test', 05:34:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:34:57 INFO - 'SHELL': '/bin/bash', 05:34:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ENvz94MB77/Listeners', 05:34:57 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 05:34:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:34:57 INFO - 'USER': 'cltbld', 05:34:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:34:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:57 INFO - 'XPC_FLAGS': '0x0', 05:34:57 INFO - 'XPC_SERVICE_NAME': '0', 05:34:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:34:57 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 05:34:57 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 05:34:57 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 05:34:57 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 05:34:57 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 05:34:57 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 05:35:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:35:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:35:00 INFO - Installing collected packages: mozsystemmonitor 05:35:00 INFO - Running setup.py install for mozsystemmonitor 05:35:00 INFO - Successfully installed mozsystemmonitor 05:35:00 INFO - Cleaning up... 05:35:00 INFO - Return code: 0 05:35:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:35:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:00 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 0x10426ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0b599270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d2d30>, '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 0x103f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041cab20>, '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.QuBHBMYjED/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.ENvz94MB77/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 05:35:00 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 05:35:00 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 05:35:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuBHBMYjED/Render', 05:35:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:00 INFO - 'HOME': '/Users/cltbld', 05:35:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:00 INFO - 'LOGNAME': 'cltbld', 05:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:00 INFO - 'MOZ_NO_REMOTE': '1', 05:35:00 INFO - 'NO_EM_RESTART': '1', 05:35:00 INFO - 'PAGER': '/bin/cat', 05:35:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:00 INFO - 'PWD': '/builds/slave/test', 05:35:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:00 INFO - 'SHELL': '/bin/bash', 05:35:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ENvz94MB77/Listeners', 05:35:00 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 05:35:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:00 INFO - 'USER': 'cltbld', 05:35:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:00 INFO - 'XPC_FLAGS': '0x0', 05:35:00 INFO - 'XPC_SERVICE_NAME': '0', 05:35:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:00 INFO - Downloading/unpacking jsonschema==2.5.1 05:35:00 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 05:35:00 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 05:35:00 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 05:35:00 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 05:35:00 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 05:35:00 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 05:35:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:35:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:35:03 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 05:35:03 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 05:35:03 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 05:35:03 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 05:35:03 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 05:35:03 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 05:35:03 INFO - Downloading functools32-3.2.3-2.tar.gz 05:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:35:03 INFO - warning: no files found matching '*.txt' 05:35:03 INFO - no previously-included directories found matching 'build' 05:35:03 INFO - no previously-included directories found matching 'dist' 05:35:03 INFO - no previously-included directories found matching '.git*' 05:35:03 INFO - Installing collected packages: jsonschema, functools32 05:35:04 INFO - Running setup.py install for functools32 05:35:04 INFO - warning: no files found matching '*.txt' 05:35:04 INFO - no previously-included directories found matching 'build' 05:35:04 INFO - no previously-included directories found matching 'dist' 05:35:04 INFO - no previously-included directories found matching '.git*' 05:35:04 INFO - Successfully installed jsonschema functools32 05:35:04 INFO - Cleaning up... 05:35:04 INFO - Return code: 0 05:35:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:35:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:04 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 0x10426ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0b599270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d2d30>, '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 0x103f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041cab20>, '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.QuBHBMYjED/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.ENvz94MB77/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 05:35:04 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 05:35:04 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 05:35:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuBHBMYjED/Render', 05:35:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:04 INFO - 'HOME': '/Users/cltbld', 05:35:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:04 INFO - 'LOGNAME': 'cltbld', 05:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:04 INFO - 'MOZ_NO_REMOTE': '1', 05:35:04 INFO - 'NO_EM_RESTART': '1', 05:35:04 INFO - 'PAGER': '/bin/cat', 05:35:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:04 INFO - 'PWD': '/builds/slave/test', 05:35:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:04 INFO - 'SHELL': '/bin/bash', 05:35:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ENvz94MB77/Listeners', 05:35:04 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 05:35:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:04 INFO - 'USER': 'cltbld', 05:35:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:04 INFO - 'XPC_FLAGS': '0x0', 05:35:04 INFO - 'XPC_SERVICE_NAME': '0', 05:35:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:04 INFO - Downloading/unpacking blobuploader==1.2.4 05:35:04 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 05:35:04 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 05:35:04 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 05:35:04 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 05:35:04 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 05:35:04 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 05:35:06 INFO - Downloading blobuploader-1.2.4.tar.gz 05:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:35:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:35:07 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 05:35:07 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 05:35:07 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 05:35:07 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 05:35:07 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 05:35:07 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 05:35:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:35:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:35:07 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 05:35:07 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 05:35:07 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 05:35:07 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 05:35:07 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 05:35:07 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 05:35:08 INFO - Downloading docopt-0.6.1.tar.gz 05:35:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:35:08 INFO - Installing collected packages: blobuploader, requests, docopt 05:35:08 INFO - Running setup.py install for blobuploader 05:35:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:35:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:35:08 INFO - Running setup.py install for requests 05:35:08 INFO - Running setup.py install for docopt 05:35:09 INFO - Successfully installed blobuploader requests docopt 05:35:09 INFO - Cleaning up... 05:35:09 INFO - Return code: 0 05:35:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:09 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 0x10426ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0b599270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d2d30>, '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 0x103f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041cab20>, '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.QuBHBMYjED/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.ENvz94MB77/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 05:35:09 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 05:35:09 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 05:35:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuBHBMYjED/Render', 05:35:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:09 INFO - 'HOME': '/Users/cltbld', 05:35:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:09 INFO - 'LOGNAME': 'cltbld', 05:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:09 INFO - 'MOZ_NO_REMOTE': '1', 05:35:09 INFO - 'NO_EM_RESTART': '1', 05:35:09 INFO - 'PAGER': '/bin/cat', 05:35:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:09 INFO - 'PWD': '/builds/slave/test', 05:35:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:09 INFO - 'SHELL': '/bin/bash', 05:35:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ENvz94MB77/Listeners', 05:35:09 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 05:35:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:09 INFO - 'USER': 'cltbld', 05:35:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:09 INFO - 'XPC_FLAGS': '0x0', 05:35:09 INFO - 'XPC_SERVICE_NAME': '0', 05:35:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:35:09 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-9pDYm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:35:09 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-1zNdSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:35:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-FPwTfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:35:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-5_Hw9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:35:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-oDCKfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:35:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-a4lzF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:35:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Sg3_O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:35:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Ngi625-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:35:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-OQFZSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:35:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-ltwGPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:35:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-N0F9Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:35:11 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-6hwsAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:35:11 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-lQP_yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:35:11 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-ynCnN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:11 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-dHdQpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:35:11 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-BgA9dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:35:11 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-klwY5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:35:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:35:11 INFO - Running setup.py install for manifestparser 05:35:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:35:11 INFO - Running setup.py install for mozcrash 05:35:11 INFO - Running setup.py install for mozdebug 05:35:12 INFO - Running setup.py install for mozdevice 05:35:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:35:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:35:12 INFO - Running setup.py install for mozfile 05:35:12 INFO - Running setup.py install for mozhttpd 05:35:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:35:12 INFO - Running setup.py install for mozinfo 05:35:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:35:12 INFO - Running setup.py install for mozInstall 05:35:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:35:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:35:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:35:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:35:12 INFO - Running setup.py install for mozleak 05:35:12 INFO - Running setup.py install for mozlog 05:35:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:35:13 INFO - Running setup.py install for moznetwork 05:35:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:35:13 INFO - Running setup.py install for mozprocess 05:35:13 INFO - Running setup.py install for mozprofile 05:35:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:35:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:35:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:35:13 INFO - Running setup.py install for mozrunner 05:35:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:35:13 INFO - Running setup.py install for mozscreenshot 05:35:13 INFO - Running setup.py install for moztest 05:35:14 INFO - Running setup.py install for mozversion 05:35:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:35:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:35:14 INFO - Cleaning up... 05:35:14 INFO - Return code: 0 05:35:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:14 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 0x10426ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0b599270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d2d30>, '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 0x103f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041cab20>, '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.QuBHBMYjED/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.ENvz94MB77/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 05:35:14 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 05:35:14 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 05:35:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuBHBMYjED/Render', 05:35:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:14 INFO - 'HOME': '/Users/cltbld', 05:35:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:14 INFO - 'LOGNAME': 'cltbld', 05:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:14 INFO - 'MOZ_NO_REMOTE': '1', 05:35:14 INFO - 'NO_EM_RESTART': '1', 05:35:14 INFO - 'PAGER': '/bin/cat', 05:35:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:14 INFO - 'PWD': '/builds/slave/test', 05:35:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:14 INFO - 'SHELL': '/bin/bash', 05:35:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ENvz94MB77/Listeners', 05:35:14 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 05:35:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:14 INFO - 'USER': 'cltbld', 05:35:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:14 INFO - 'XPC_FLAGS': '0x0', 05:35:14 INFO - 'XPC_SERVICE_NAME': '0', 05:35:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:35:14 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-_tAqHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:35:14 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)) 05:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:35:14 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-ubR75u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:35:14 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)) 05:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:35:14 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-WsmOlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:35:14 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)) 05:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:35:14 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-tMzwFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:35:14 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)) 05:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:35:14 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-szYhsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:35:15 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)) 05:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:35:15 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-APNvlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:35:15 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)) 05:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:35:15 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-jIA8tP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:35:15 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)) 05:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:35:15 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-8zRTnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:35:15 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)) 05:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:35:15 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-o9QqH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:35:15 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)) 05:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:35:15 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-7bhAjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:35:15 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)) 05:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:35:15 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-vpynva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:35:15 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)) 05:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:35:15 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Jaj_uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:35:15 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)) 05:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:35:15 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-xw6wkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:35:15 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)) 05:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:35:15 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-7K50Ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:35:16 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)) 05:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:16 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Agi7Z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:16 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)) 05:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:35:16 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-GB_cbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:35:16 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)) 05:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:35:16 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-87iVbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:35:16 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)) 05:35:16 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)) 05:35:16 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)) 05:35:16 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)) 05:35:16 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)) 05:35:16 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)) 05:35:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:18 INFO - Downloading blessings-1.6.tar.gz 05:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:35:18 INFO - Installing collected packages: blessings 05:35:18 INFO - Running setup.py install for blessings 05:35:18 INFO - Successfully installed blessings 05:35:18 INFO - Cleaning up... 05:35:19 INFO - Return code: 0 05:35:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:35:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:35:19 INFO - Reading from file tmpfile_stdout 05:35:19 INFO - Current package versions: 05:35:19 INFO - blessings == 1.6 05:35:19 INFO - blobuploader == 1.2.4 05:35:19 INFO - docopt == 0.6.1 05:35:19 INFO - functools32 == 3.2.3-2 05:35:19 INFO - jsonschema == 2.5.1 05:35:19 INFO - manifestparser == 1.1 05:35:19 INFO - mozInstall == 1.12 05:35:19 INFO - mozcrash == 0.17 05:35:19 INFO - mozdebug == 0.1 05:35:19 INFO - mozdevice == 0.48 05:35:19 INFO - mozfile == 1.2 05:35:19 INFO - mozhttpd == 0.7 05:35:19 INFO - mozinfo == 0.9 05:35:19 INFO - mozleak == 0.1 05:35:19 INFO - mozlog == 3.3 05:35:19 INFO - moznetwork == 0.27 05:35:19 INFO - mozprocess == 0.23 05:35:19 INFO - mozprofile == 0.28 05:35:19 INFO - mozrunner == 6.12 05:35:19 INFO - mozscreenshot == 0.1 05:35:19 INFO - mozsystemmonitor == 0.3 05:35:19 INFO - moztest == 0.7 05:35:19 INFO - mozversion == 1.4 05:35:19 INFO - psutil == 3.1.1 05:35:19 INFO - requests == 1.2.3 05:35:19 INFO - wsgiref == 0.1.2 05:35:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:19 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 0x10426ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0b599270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d2d30>, '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 0x103f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041cab20>, '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.QuBHBMYjED/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.ENvz94MB77/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 05:35:19 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 05:35:19 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 05:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuBHBMYjED/Render', 05:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:19 INFO - 'HOME': '/Users/cltbld', 05:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:19 INFO - 'LOGNAME': 'cltbld', 05:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:19 INFO - 'MOZ_NO_REMOTE': '1', 05:35:19 INFO - 'NO_EM_RESTART': '1', 05:35:19 INFO - 'PAGER': '/bin/cat', 05:35:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:19 INFO - 'PWD': '/builds/slave/test', 05:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:19 INFO - 'SHELL': '/bin/bash', 05:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ENvz94MB77/Listeners', 05:35:19 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 05:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:19 INFO - 'USER': 'cltbld', 05:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:19 INFO - 'XPC_FLAGS': '0x0', 05:35:19 INFO - 'XPC_SERVICE_NAME': '0', 05:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:19 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)) 05:35:19 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)) 05:35:19 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)) 05:35:19 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)) 05:35:19 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)) 05:35:19 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)) 05:35:19 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)) 05:35:19 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)) 05:35:19 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)) 05:35:19 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)) 05:35:19 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)) 05:35:19 INFO - Cleaning up... 05:35:19 INFO - Return code: 0 05:35:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:35: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10426ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0b599270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d2d30>, '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 0x103f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041cab20>, '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.QuBHBMYjED/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.ENvz94MB77/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 05:35: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', 'jsonschema'] in /builds/slave/test/build 05:35: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 jsonschema 05:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuBHBMYjED/Render', 05:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:19 INFO - 'HOME': '/Users/cltbld', 05:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:19 INFO - 'LOGNAME': 'cltbld', 05:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:19 INFO - 'MOZ_NO_REMOTE': '1', 05:35:19 INFO - 'NO_EM_RESTART': '1', 05:35:19 INFO - 'PAGER': '/bin/cat', 05:35:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:19 INFO - 'PWD': '/builds/slave/test', 05:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:19 INFO - 'SHELL': '/bin/bash', 05:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ENvz94MB77/Listeners', 05:35:19 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 05:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:19 INFO - 'USER': 'cltbld', 05:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:19 INFO - 'XPC_FLAGS': '0x0', 05:35:19 INFO - 'XPC_SERVICE_NAME': '0', 05:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:35:19 INFO - Cleaning up... 05:35:19 INFO - Return code: 0 05:35:19 INFO - Running post-action listener: _resource_record_post_action 05:35:19 INFO - Running post-action listener: _start_resource_monitoring 05:35:19 INFO - Starting resource monitoring. 05:35:19 INFO - [mozharness: 2016-07-21 12:35:19.946644Z] Finished create-virtualenv step (success) 05:35:19 INFO - [mozharness: 2016-07-21 12:35:19.947581Z] Running install step. 05:35:19 INFO - Running pre-action listener: _resource_record_pre_action 05:35:19 INFO - Running main action method: install 05:35:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:35:20 INFO - Reading from file tmpfile_stdout 05:35:20 INFO - Detecting whether we're running mozinstall >=1.0... 05:35:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:35:20 INFO - Reading from file tmpfile_stdout 05:35:20 INFO - Output received: 05:35:20 INFO - Usage: mozinstall [options] installer 05:35:20 INFO - Options: 05:35:20 INFO - -h, --help show this help message and exit 05:35:20 INFO - -d DEST, --destination=DEST 05:35:20 INFO - Directory to install application into. [default: 05:35:20 INFO - "/builds/slave/test"] 05:35:20 INFO - --app=APP Application being installed. [default: firefox] 05:35:20 INFO - mkdir: /builds/slave/test/build/application 05:35:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:35:55 INFO - Reading from file tmpfile_stdout 05:35:55 INFO - Output received: 05:35:55 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:35:55 INFO - Running post-action listener: _resource_record_post_action 05:35:55 INFO - [mozharness: 2016-07-21 12:35:55.379143Z] Finished install step (success) 05:35:55 INFO - [mozharness: 2016-07-21 12:35:55.379281Z] Running run-tests step. 05:35:55 INFO - Running pre-action listener: _resource_record_pre_action 05:35:55 INFO - Running main action method: run_tests 05:35:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:35:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:35:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:35:55 INFO - 2016-07-21 05:35:55.393 screenresolution[1643:8379] starting screenresolution argv=screenresolution get 05:35:55 INFO - 2016-07-21 05:35:55.396 screenresolution[1643:8379] Display 0: 1600x1200x32@60 05:35:55 INFO - 2016-07-21 05:35:55.402 screenresolution[1644:8381] starting screenresolution argv=screenresolution list 05:35:55 INFO - Available Modes on Display 0 05:35:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:35:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:35:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:35:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:35:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:35:55 INFO - Intel Iris: 05:35:55 INFO - Chipset Model: Intel Iris 05:35:55 INFO - Type: GPU 05:35:55 INFO - Bus: Built-In 05:35:55 INFO - VRAM (Dynamic, Max): 1536 MB 05:35:55 INFO - Vendor: Intel (0x8086) 05:35:55 INFO - Device ID: 0x0a2e 05:35:55 INFO - Revision ID: 0x0009 05:35:55 INFO - Displays: 05:35:55 INFO - Display: 05:35:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:35:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:35:55 INFO - Display Serial Number: 1600x1200 60 05:35:55 INFO - Main Display: Yes 05:35:55 INFO - Mirror: Off 05:35:55 INFO - Online: Yes 05:35:55 INFO - Rotation: Supported 05:35:55 INFO - Return code: 0 05:35:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:35:55 INFO - Python 2.7.3 05:35:55 INFO - Return code: 0 05:35:55 INFO - grabbing minidump binary from tooltool 05:35:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:55 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 0x1041d2d30>, '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 0x103f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041cab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:35:55 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 05:35:55 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 05:35:55 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 05:35:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:35:55 INFO - Return code: 0 05:35:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:35:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:35:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:35:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:35:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:35:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0268', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0268 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:35:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuBHBMYjED/Render', 05:35:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:55 INFO - 'HOME': '/Users/cltbld', 05:35:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:55 INFO - 'LOGNAME': 'cltbld', 05:35:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:35:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:55 INFO - 'MOZ_NO_REMOTE': '1', 05:35:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:35:55 INFO - 'NO_EM_RESTART': '1', 05:35:55 INFO - 'PAGER': '/bin/cat', 05:35:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:55 INFO - 'PWD': '/builds/slave/test', 05:35:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:35:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:55 INFO - 'SHELL': '/bin/bash', 05:35:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ENvz94MB77/Listeners', 05:35:55 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 05:35:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:55 INFO - 'USER': 'cltbld', 05:35:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:55 INFO - 'XPC_FLAGS': '0x0', 05:35:55 INFO - 'XPC_SERVICE_NAME': '0', 05:35:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0268', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:35:55 INFO - mozversion application_buildid: 20160721030216 05:35:55 INFO - mozversion application_changeset: d224fc999cb6accb208af0a105f14433375e2e77 05:35:55 INFO - mozversion application_display_name: Nightly 05:35:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:35:55 INFO - mozversion application_name: Firefox 05:35:55 INFO - mozversion application_remotingname: firefox 05:35:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:35:55 INFO - mozversion application_vendor: Mozilla 05:35:55 INFO - mozversion application_version: 50.0a1 05:35:55 INFO - mozversion platform_buildid: 20160721030216 05:35:55 INFO - mozversion platform_changeset: d224fc999cb6accb208af0a105f14433375e2e77 05:35:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:35:55 INFO - mozversion platform_version: 50.0a1 05:35:55 INFO - using testdate: 1469104555 05:35:55 INFO - actual date: 1469104555 05:35:55 INFO - starting webserver on 'localhost:49274' 05:35:55 INFO - SUITE-START | Running 2 tests 05:35:55 INFO - TEST-START | dromaeo_css 05:35:55 INFO - operating with platform_type : mac_ 05:35:55 INFO - Initialising browser for dromaeo_css test... 05:35:56 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpm1u7lr/profile http://localhost:49274/getInfo.html) 05:35:58 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 05:35:58 INFO - PROCESS | 1654 | colorDepth:24 05:35:58 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 05:35:58 INFO - PROCESS | 1654 | __metrics 05:35:58 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:35:58 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:35:59 INFO - TEST-INFO | 1654: exit 0 05:35:59 INFO - Browser initialized. 05:35:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:35:59 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpm1u7lr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:11 INFO - PROCESS | 1658 | RSS: Main: 245600256 05:36:11 INFO - PROCESS | 1658 | 05:37:02 INFO - PROCESS | 1658 | 1469104622298 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] 05:39:13 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 05:39:14 INFO - PROCESS | 1658 | RSS: Main: 355246080 05:39:14 INFO - PROCESS | 1658 | 05:42:17 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 05:42:18 INFO - PROCESS | 1658 | RSS: Main: 376897536 05:42:18 INFO - PROCESS | 1658 | 05:45:20 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 05:45:21 INFO - PROCESS | 1658 | RSS: Main: 370774016 05:45:21 INFO - PROCESS | 1658 | 05:48:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 05:48:24 INFO - PROCESS | 1658 | RSS: Main: 374910976 05:48:24 INFO - PROCESS | 1658 | 05:51:27 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 05:51:28 INFO - PROCESS | 1658 | RSS: Main: 346439680 05:51:28 INFO - PROCESS | 1658 | 05:54:31 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 05:54:31 INFO - PROCESS | 1658 | RSS: Main: 408817664 05:54:31 INFO - PROCESS | 1658 | 05:54:31 INFO - PROCESS | 1658 | __start_tp_report 05:54:31 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 05:54:31 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 05:54:31 INFO - PROCESS | 1658 | |i|pagename|runs| 05:54:31 INFO - PROCESS | 1658 | |0;dojo.html;3347.1966727985287;3362.5124356968226;3370.191154123011;3372.9325413491724;3438.9312213755725;5584.301962254718;5673.319201695802;5680.403557626447;5742.598018138732;5789.652620842747;5685.630434021786;5690.60165788394;5803.912941305874;5818.5926985111055;5822.592418530705;5148.304978827848;5206.401263854648;5207.036698210824;5211.765470553815;5318.069337865877;5346.866328341784;5350.678959262456;5359.919601205985;5371.623986320959;5383.16560933054;5133.230015497668;5193.974030129825;5194.194899790538;5235.240890070937;5279.656822306538;5159.793608255665;5222.869428264324;5256.395514515842;5258.211268309784;5266.15741481365;5155.561777248939;5191.6625419348;5199.038177937094;5257.658252213594;5276.947230527684;5729.0260655688635;5749.0801471764735;5763.366029736726;5815.825525234208;5831.970840145772;6090;6136.1821086261625;6246;6255.906161407583;6283.497320214372;5580.637258578179;6265.530085243625;6297;6323.7786677466065;6326.715297811609;5854.765809367663;5888.499477544414;5912.852178695524;5918.348981612019;5920.171176035358;6128.356522565066;6250;6255.74977000924;6280.183576135073;6287.402696743802;6099.43084549468;6166.105914642351;6182.69086545671;6184.6598437085495;6196.256449226122;6293.3391993840905;6301.8109456716375;6309.716062777186;6311.936880631227;6317.96841015792;6084.969575152184;6109.175261339751;6248.656323902229;6254.34329395416;6270.7491700331475;5130.563902068366;6155.353687862799;6183.628982261079;6185.567010309235;6189.133521307021;4922.803087876445;4971.477994810565;4972.5027497249985;5004.84985450437;5020.322256495327;4465.665075119379;4467.56517697849;4469.2849144137435;4476.171908196994;4513.50351461339;5726.77092916287;5789.913151302734;5792;5801.564882633819;5857.179994800731;6144.972159187458;6188.009918413032;6204.968975155095;6275.466585340298;6288.9056664150075;5733.942660573424;5760.481556659921;5788.3343415506915;5797.449242321973;5797.797077102281;5407.540359069444;5461.453854614507;5470.398256191816;5477.04151773438;5490.066688662937;5976.282846058414;6273.404026617464;6279.96860015697;6282.591631543935;6297.653629050446;5192.324997750268;6099.309783606499;6182.876342473215;6201.441870231701;6318.810435686937;6277.309495955533;6282.623042617458;6283.528735344776;6290.9056364155485;6294.937050629435;5252.632315737862;6144.815655530341;6213.409726076015;6243.125962365363;6243.96878015607;5670.036093864135;6140.508759299156;6176.722047507783;6234.937650623436;6306.9684651576445;5533.501984821385;6137.9693101535995;6149.41580549847;6152.50779937595;6164.7842325518395;5113.590912727047;6118.921295324959;6128.655903792168;6132.386761323832;6138.539609529393;5813.447722466359;5867.295924489089;5882.058870580687;5922.703864806828;5942.257217847769;6109.780439121757;6140.078988151813;6149.477294429845;6157.9384206157365;6165.383461653978;5918.053111502139;5967.9701601491715;5971.193888825127;5975.611585246945;6004.129401236709 05:54:31 INFO - PROCESS | 1658 | |1;ext.html;506.2381116419788;520.5159201942193;521.3144714700171;525.3564383630054;568.173307837097;30531.847340763292;41162.79418602907;41957;42066.57933420669;44147.77926110365;43480.56519434813;43812.780936095274;43869.12261754771;43910.56089439105;43919.56080439195;9776.315657903931;9980.401175929432;9984.151347135503;9987.201023918105;9992.650257240997;8790.16493433126;9020.41367311126;12035;12248.020158387308;12254.81617775734;12217.20588161771;12265.816012759815;12276.263424194532;12279.69300767479;12292.508299668003;12174.330411827346;12249.632511024683;12258.693532661666;12267.3252971087;12274.509019639203;8795.736127916172;9002.504862232574;9002.594883230206;9098.317626178063;11822.645320640395;32181.517277240626;41300;41690.58309416928;41693.37459938104;41763;3495.667911548399;3554.3424466473525;3584.032311275941;3705.184859330943;3852.9422058669143;31168.8441557793;31394.37211255762;32426;32445.675543244502;32447.837760811046;3298.0765385692043;3368.3768502827056;3399.8810041648426;3404.5914490261325;3438.5529881115544;532969.9999999962;534296;535212;536532;537078;60547.789044218865;60682.69658651767;60720;60784.08823867646;60916;64485.67757161184;64625.03062454067;64738;64743.67628161829;64826;16315.1026693533;16493.257803398876;16540.917295413445;16573.91713041427;16663;9634.277429192838;11808.232464889927;11834.289942603471;12013.219140755822;12036.75926481483;16380.26288817006;16792.99242045481;16801.663966720596;16941;17207.1396430178;6073.96963015191;6723.189939056136;6810.455163587;6880.346367095118;6906.171259448798;821.7247222180637;885.9778505537284;916.2852974679761;965.6137544982064;1015.0914931136739;28065.71934280672;29516.852415737783;29559.704402956126;30286.242843928638;30398.848005759828;1007.3351587951917;1025.4052649463292;1075.575147816608;1078.7626722121122;1121.9439028048728;13615.455381784815;15467.381304747909;15916.283767230503;15966.647004129263;16390.754138687927;688151;694856;695079;695877;698159;52430.737846311284;59714.70142649259;59757.701211493666;59783.40216597865;59878.802423951274;1259.5024965138718;1275.6300672804969;1316.8617295183867;1328.7076843094503;1428.164523753595;27812.30469238285;28652.28369290701;32249;32617.836910815295;32732.836335818167;55332;56039;56149.71925140348;56191.43808561862;56208;640575;649028;649618;649920;650205;34524;38254.42618360671;40775;41110.794446027576;42270.57729422666;46255.07489850117;47391;47650.76174619105;48270;48301.516984831105;39161.41257881077;39342.606573933896;39577.604223957394;40355.59644403518;40693.79653101716;38738.837834865;38888.222235555695;39658.80170599128;40576;40621.390679139244;38242.6175738239;38543.614563855124;38633.42049869311;39142.02144946399;39306.213875721754;32684.50973235356;34723.95628665378;34777;34842;34980.30039399249;25610.10364637229;25738.4556926585;26146.215613531625;26332.8683356582;26533.33666658349 05:54:31 INFO - PROCESS | 1658 | |2;jquery.html;358.4891529570362;360.81237756366704;377.84697197634966;394.38475977475133;412.7358490566036;15587.610309742262;15608.531744047683;20285.47858910584;20478.28326008592;20512.794872051276;20763.857987810665;21356.679649805264;21369.465763355925;22999.655005174936;23807.28578142654;6606.8678626427445;6665.966670166642;6852.314768523158;6940.13248343957;6967.895481567781;4574.908501829961;6753.628550429725;6860.5540639858245;6860.862782744342;6866.690998905061;7475.551466911976;7803.921960780404;7893.565853878034;7913.28780409763;7963.203679632019;7735.535867847919;7773.766786996399;7900.841983160304;7936.246056624612;7939.206079392073;7187.209406965229;7573.431992600577;7596.962015189889;7624.961875190644;7662.923370766277;24240.636390454158;29641.703582964325;30131.69868301333;30182.69817301821;30207.848960755055;2530.4433024734712;2622.2002289301754;2630.118910165097;2713.72862713729;3185.729213016896;12954.611361659165;14158.929205353907;17123.57191070221;17615.823841761547;17917.283308667636;2012.2655230840637;2016.90923908423;2050.5693804301113;2060.917563297466;2062.886541240231;150961.24519377333;151657;153567;153608;155954.99999999886;21098.47253818636;21837;21856.125754969624;22230.55538889213;22404.887975560017;36986;36993.81503092521;37049.518019279465;37049.81475092661;37197;10747.40889251083;10956.726081848017;11051.944740276407;11057.834132488018;11353.716157095974;7307.3423391894985;7439.739609113655;8997.775055623662;9051.597002464629;9239.584218710039;9846.803063938682;9934.105930466292;9976.251781116445;9990.450525221182;10113.595456181818;3199.40810949975;3211.823349715741;3684.889453316405;3805.942910856284;3818.560865500503;901;937.8358787212347;945.5886689290181;976.9951150244345;988.4859872866069;20888;21442.463938401354;22008.669869951962;22058.44853878666;22200.555988880133;909.4770506958525;934.4440058165517;938.1744065222697;959.7744530035436;1037.387941114731;10835.241533092609;11259.549618015351;11601.099725068732;11634.36011019402;11688.883111168949;632970;635582;636325;638780;654463;109340.45329773301;131510;132422;144047.55952440551;145581;823.8187598728271;947.2564037230741;992.1517102876936;1007.0634310091685;1012.0486742462062;18568.907155464676;19473.83157010584;19513.512162196057;19570.60858782845;19600.9019954905;45894.541054589026;59658;59737;60718.08922866249;60755;84510;85217;87238.56380718056;87768.56115719635;87904.5604771972;7722.111957125003;8026.317762990211;8136.696501220429;8262.256396924306;8506.191911768372;12879.969602431596;13388.598342049365;13460.326983650973;13477;14086.788698169741;11534.59628912984;11572.826407603725;11949.283043017447;12010.819837702267;12086.45610947527;9342.439453632804;11643.825342619699;11902.107341949562;11997.940010300243;11999.700007499883;11666.416679165837;11771.646850594154;11993.460294286604;12109;12188.390580470763;8193.959030204811;8217;8508.27679647237;8652.048274689905;8681.609327580149;11319.09447244202;11552.480138393961;11585.246958947642;11996.940015299868;12039.939800300943 05:54:31 INFO - PROCESS | 1658 | |3;mootools.html;1590.3479573374916;1627.462937230714;1848.8151184881513;1944.6791279438894;1961.264525802823;8752.29981601472;9207.67773127939;9210.447373157607;9225.538723063837;9227.446353218804;7960.402969777261;8212.1787821218;8223.588820558964;8591.441556298836;8988.595513201904;2352.458934445074;2395.3412811476896;2397.1729753235104;2406.8916898739512;2408.915687950922;2360.1975328388344;2384.2847145856263;2393.8803059847023;2398.868062256584;2402.8077753779744;2093.811556959873;2312.5721741477882;2378.2746262389965;2388.976110238893;2402.327348342458;2386.0217310902535;2405.6992875890514;2408.5664580375615;2408.903643854261;2409.3133456964856;2375.2755409600063;2390.2829151254728;2397.520495900827;2401.579723548372;2401.795847352977;7729.34300584451;9100.99889012208;9183.816323673556;9185.49479778612;9185.49479778612;5275.235090911796;5375.596830237709;5426.593005524562;5446.210299506589;5458.699771512565;3525.594556625995;3545.503629491873;3615.94576081359;3702.4631428442995;3702.611225821277;1079.9028087472166;1083.2796190533286;1091.730267847793;1095.6986828622114;1113.204059097749;11739.823902641467;11917.986971107466;11955.222910510876;11957.282563046245;11959.043276537943;4595.356650068993;4641.535846415399;4797.40032495938;4828.686135401188;4829.492903245179;10118.848217276747;10123.139533139618;10124.443155626512;10132.746681333025;10138.442385668859;5413.188021796684;5414.512693857571;5419.295491586068;5423.078076726966;5428.158635411518;3610.819459027038;4342.891427714332;4590.127875703605;4962.354893863775;4965.131102057126;3949.4668219790533;3988.6011398859882;4011.6590089842107;4057.0323393154295;4096.1193343431305;1277.1060257819563;1280.9679758006125;1284.621036794148;1297.0531511996107;1297.740451909622;644.7388807532957;820.33552822213;922.7508572685338;962.2206013129247;983.026803464565;5927.792527261525;5998.25021872266;6004.129401236796;6028.638281703112;6052.909206361908;864.2696921101659;980.5391466010964;980.8234517786724;993.64228877604;1009.707184916366;3523.524324216249;4054.8580799671868;4168.91662166761;4170.22850772608;4170.249355116048;10329.173666106693;10443.268971171945;10480;10855.2401331906;10869.130469562417;10801.78396432067;10815.567377304977;10817.405042722568;10819.18856085781;10826.783464330827;8151.144129866398;8272.131426200162;8272.33821294295;8342.833143337099;8352.498850069016;5815.5929084963645;5922.407759224043;6012.909806352821;6054.969725151346;6064.090386442069;10054.396736195558;10113.14038306752;10150.949245253727;10151.898481015096;10179.03299186576;10021.448820314952;10088.495575221357;10105.19158467306;10199.490025498844;10323.32898361604;7348.081489813773;7519.962400188183;7526.661300241392;7534.736284230025;7549.433792465697;8146.5519396433765;8270.462419942685;8320.542370169698;8353.749387518385;8367.95816020916;7447.5531468112085;7449.106107267163;7512.699492020258;7544.358729508053;7603.505772124794;7297.890531642136;7378.167156155238;7399.889001664872;7491.625418729151;7513.173550909286;6988.965055174692;7029.226785053538;7145.21402645719;7151.7854464366155;7157.7136914522835;4895.1922932717125;4980.402351717817;5014.648974571745;5024.799008039638;5172.948270517247;4977.278294647328;5030.220315851049;5051.6716413433005;5102.591792656653;5233.450487698889 05:54:31 INFO - PROCESS | 1658 | |4;prototype.html;300.76540298567124;304.9496833022551;311.8658976640045;315.45583867827986;316.6232183701395;4628.791704373303;5379.8386048418515;5556.91664625031;5577.832665020051;5631.943680563193;5205.063088644042;5304;5534.612577119593;5554.166874968757;5604.439556044394;4215.704900656955;4221.662267018646;4222.68329875259;4264.2537555927665;4277;3893.0462036801023;4098.692598055143;4206.305959516676;4266.954596123954;4277.716684994505;3947.960520394802;4103.8563650272245;4211.473565804275;4216.9578304216875;4248.660107191417;4203.831846726127;4208.936865947013;4234.449521562208;4241.7879106044575;4269.124829409994;3167.857446414917;3674.173311005029;3680.405314253445;3680.6687398134027;3686.3548878946076;4966.329545511346;5359.517643412111;5397.379301380352;5418.7019713915715;5454.863628409322;4403.427554417937;4840.15297322967;4854.271859221145;4860.562549370574;4872.585830204437;4935.901281974377;5530.170474428827;5543.309290666385;5862.186150647671;5934.465898069195;3596.946045809315;3789.905252368685;3801.619838016204;3999.5200575930785;4041.5150181978056;5859.589828711992;6115.785947491817;6199.349068347804;6204.81385558434;6229.31477537466;3800.6959443245028;3936.0553467167674;4095.97952010244;4117.155983023473;4122.546519882811;3203.7757356985253;4135.813888375031;4135.855245066408;4177.456930599003;4197.202531519001;4754.5245475452175;4824.517548245218;4831.975840120847;4871.756412179377;4896.387951506062;5552.805651802168;5793.594448388572;5850.970745146247;5893.5579831512805;5937.940620593825;1168.807146820782;1290.4386591832583;1425.3657122580353;1428.8356838963653;1433.376481230668;827.3422629009951;837.5937670229933;876.3077169036517;890.6036813618007;897.241830653097;3995.6004399560393;4185.100203456272;4558.766204559742;4652.743759185001;4671.462781780071;3972.3842804365368;4648.442186937589;5062.721550314768;5085.64400491962;5098.974505127525;4061.3501839706096;4108.931677763803;4628.236341003764;4645.372874661945;4654.767261636973;2305.561943230781;2476;2534.961975570368;2670.692870319899;2695.245331307237;5199.0641684496395;5247.606429517801;5253.632245742761;5257.947420525746;5296.576273898079;4877.463479017305;4962.478939711351;5200.583953283728;5251.52736253739;5282.920756188661;4704.270838020112;4774.976125119352;4818.494058123846;5237.319148510745;5342.813001544927;4133.305344808614;4515.2549829277805;4919.286703428054;5102.265229821878;5126.820561280338;4029.9395509066803;4608.700434471749;5008.373953255843;5017.591556053042;5057;4449.733016018919;4971.37857767779;5024.683708752206;5225.9216111759115;5244.842654720212;3615.6565126312958;3631.854725810938;3859.4789703389683;3956.931628460242;4045.271851066836;4945.97527012377;5099.515546023122;5224.60815438836;5694.345150307768;5894.764209431574;4710.974281059178;5753.827385178452;5809.9419005809405;5824.912626310524;5840.984860223216;5537.750801213874;5793.449622285876;5854.209681692917;5913.615614985012;5938.703064846654;5010;5656.88686226265;5813.186153938536;5825.883482330245;5830.183774271521;5706.828795136153;5940.940590594038;5961.8807623846415;6026.8794624106395;6031.276246850406;5000.974995125001;5653.756173641792;5734.54123670097;5761.596688231783;5774.585226619505 05:54:31 INFO - PROCESS | 1658 | |5;yui.html;738.1953670499156;746.6751962896141;769.0348612491323;801.0107517216237;848.2747251100313;15139.394424223032;16380.262888170031;16406.179691015463;16407.343706251737;16434.424795132174;14798.704025919475;14952.925235373836;14962.251887405613;14981.775273370908;15011.32449039793;710.9253528379523;733.9009233753455;865.5239618209976;870.6647940542873;901.7790641292893;890.1765866573394;890.9821803563925;897.0177655467253;897.407710910799;898.137787723786;870.4168207301124;885.4946590795673;952.4095061062117;953.0659953245823;959.1751094059103;735.3235023778137;927.429630777074;945.2390825385596;947.7109481608106;948.2035090523958;707.4305184326615;714.653393104344;716.3767522255619;717.0892965933288;718.7268837841639;15086.17026063577;15121.941464097517;15130.092194468367;15134.243287835674;15160.938734288604;14145.717085658333;14284.714305713931;14349.497767578188;14356.856431435657;14502.927485362507;12879.806802897963;13121.343932803416;13122.671933201651;13400;13640.93179534106;3957.7823219722904;4619.884502887421;4672.3692301539195;4803.567678908915;4842.346283251786;116348.99999999916;117647;117904.41047794792;119570.4021479887;123009;11192.216544841784;11254.774904502028;11360.431978401048;11844.170908036354;11945.044396448264;23000.309990700305;23049.769502304764;23055.42361440944;23075.19236826703;23105.19131830378;7989.880151797728;8030.478018928751;8149.878695300561;8335.083140854502;8381.539015354214;4373.2565463871215;4501.572350626685;4503.842365517191;4564.292534657134;4669.836555720602;3382.2728113455723;3491.389006923778;3494.3884820156372;3495.528103706018;3500.1074725944723;548.4707257496456;637.4454224824433;645.9580127291711;650.817771024114;657.3196741372657;554.7448173839998;599.2509363295881;603.9396060394014;619.5817822969477;664.4817042706696;6847;7608.771736847792;9027.322950778718;9157.313201509913;9218.354715170008;586.3960121075299;630.1052505442283;642.1780121444558;643.4048505132733;647.8186107889799;3988.3419235825763;4069.348904175318;4584.106099310669;4674.672772905864;4713.057388522309;113867;120659;124523.75476245122;152390;170206;103293.93412131866;110880.89119108867;128553.71446285417;131427;133748;95645.5217723907;111476.88523114665;113124;113647.43176284232;121846;8084.312833408991;10005.699829005142;10176.796464070825;10230.795384092426;10237.744056398351;53158;61697.38302616916;63981.68009159924;64654;65319.34680653323;90660.64009040002;94466;96495.51752241194;97794;99661;13011.414486347947;13451.260180689764;13481.524967537413;13865.23741194244;14021.439142434188;15084.170370629721;15304.234788260765;15365;16088.517344479684;16115.194240288172;14078.084924479876;14184.078034927697;14189.929050354682;14318;14425.927870360581;14159.858401416266;14171.716565668836;14180;14272.00095993312;14823.481178158712;13630.591082267549;13768.24274664903;14004.78992815129;14155.221462819643;14222.8621710265;10976;11292.679423230196;11387.202895797545;11416.086713062768;11460.770784584094;10155.949220253851;10287.794244114926;10555.841662374916;11134.665960021212;11379 05:54:31 INFO - PROCESS | 1658 | __end_tp_report 05:54:31 INFO - PROCESS | 1658 | __start_cc_report 05:54:31 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1174 05:54:31 INFO - PROCESS | 1658 | __end_cc_report 05:54:31 INFO - PROCESS | 1658 | __startTimestamp1469105671548__endTimestamp 05:54:31 INFO - PROCESS | 1658 | 05:54:31 INFO - PROCESS | 1658 | ------- Summary: start ------- 05:54:31 INFO - PROCESS | 1658 | Number of tests: 6 05:54:31 INFO - PROCESS | 1658 | 05:54:31 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5735.71 Median:5912.85 stddev:624.71 (10.6%) stddev-sans-first:597.87 05:54:31 INFO - PROCESS | 1658 | Values: 3347.2 3362.5 3370.2 3372.9 3438.9 5584.3 5673.3 5680.4 5742.6 5789.7 5685.6 5690.6 5803.9 5818.6 5822.6 5148.3 5206.4 5207.0 5211.8 5318.1 5346.9 5350.7 5359.9 5371.6 5383.2 5133.2 5194.0 5194.2 5235.2 5279.7 5159.8 5222.9 5256.4 5258.2 5266.2 5155.6 5191.7 5199.0 5257.7 5276.9 5729.0 5749.1 5763.4 5815.8 5832.0 6090.0 6136.2 6246.0 6255.9 6283.5 5580.6 6265.5 6297.0 6323.8 6326.7 5854.8 5888.5 5912.9 5918.3 5920.2 6128.4 6250.0 6255.7 6280.2 6287.4 6099.4 6166.1 6182.7 6184.7 6196.3 6293.3 6301.8 6309.7 6311.9 6318.0 6085.0 6109.2 6248.7 6254.3 6270.7 5130.6 6155.4 6183.6 6185.6 6189.1 4922.8 4971.5 4972.5 5004.8 5020.3 4465.7 4467.6 4469.3 4476.2 4513.5 5726.8 5789.9 5792.0 5801.6 5857.2 6145.0 6188.0 6205.0 6275.5 6288.9 5733.9 5760.5 5788.3 5797.4 5797.8 5407.5 5461.5 5470.4 5477.0 5490.1 5976.3 6273.4 6280.0 6282.6 6297.7 5192.3 6099.3 6182.9 6201.4 6318.8 6277.3 6282.6 6283.5 6290.9 6294.9 5252.6 6144.8 6213.4 6243.1 6244.0 5670.0 6140.5 6176.7 6234.9 6307.0 5533.5 6138.0 6149.4 6152.5 6164.8 5113.6 6118.9 6128.7 6132.4 6138.5 5813.4 5867.3 5882.1 5922.7 5942.3 6109.8 6140.1 6149.5 6157.9 6165.4 5918.1 5968.0 5971.2 5975.6 6004.1 05:54:31 INFO - PROCESS | 1658 | 05:54:31 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:75874.59 Median:39324.41 stddev:168426.91 (428.3%) stddev-sans-first:168804.33 05:54:31 INFO - PROCESS | 1658 | Values: 506.2 520.5 521.3 525.4 568.2 30531.8 41162.8 41957.0 42066.6 44147.8 43480.6 43812.8 43869.1 43910.6 43919.6 9776.3 9980.4 9984.2 9987.2 9992.7 8790.2 9020.4 12035.0 12248.0 12254.8 12217.2 12265.8 12276.3 12279.7 12292.5 12174.3 12249.6 12258.7 12267.3 12274.5 8795.7 9002.5 9002.6 9098.3 11822.6 32181.5 41300.0 41690.6 41693.4 41763.0 3495.7 3554.3 3584.0 3705.2 3852.9 31168.8 31394.4 32426.0 32445.7 32447.8 3298.1 3368.4 3399.9 3404.6 3438.6 532970.0 534296.0 535212.0 536532.0 537078.0 60547.8 60682.7 60720.0 60784.1 60916.0 64485.7 64625.0 64738.0 64743.7 64826.0 16315.1 16493.3 16540.9 16573.9 16663.0 9634.3 11808.2 11834.3 12013.2 12036.8 16380.3 16793.0 16801.7 16941.0 17207.1 6074.0 6723.2 6810.5 6880.3 6906.2 821.7 886.0 916.3 965.6 1015.1 28065.7 29516.9 29559.7 30286.2 30398.8 1007.3 1025.4 1075.6 1078.8 1121.9 13615.5 15467.4 15916.3 15966.6 16390.8 688151.0 694856.0 695079.0 695877.0 698159.0 52430.7 59714.7 59757.7 59783.4 59878.8 1259.5 1275.6 1316.9 1328.7 1428.2 27812.3 28652.3 32249.0 32617.8 32732.8 55332.0 56039.0 56149.7 56191.4 56208.0 640575.0 649028.0 649618.0 649920.0 650205.0 34524.0 38254.4 40775.0 41110.8 42270.6 46255.1 47391.0 47650.8 48270.0 48301.5 39161.4 39342.6 39577.6 40355.6 40693.8 38738.8 38888.2 39658.8 40576.0 40621.4 38242.6 38543.6 38633.4 39142.0 39306.2 32684.5 34724.0 34777.0 34842.0 34980.3 25610.1 25738.5 26146.2 26332.9 26533.3 05:54:31 INFO - PROCESS | 1658 | 05:54:31 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:39452.46 Median:30195.27 stddev:107196.03 (355.0%) stddev-sans-first:107456.55 05:54:31 INFO - PROCESS | 1658 | Values: 358.5 360.8 377.8 394.4 412.7 15587.6 15608.5 20285.5 20478.3 20512.8 20763.9 21356.7 21369.5 22999.7 23807.3 6606.9 6666.0 6852.3 6940.1 6967.9 4574.9 6753.6 6860.6 6860.9 6866.7 7475.6 7803.9 7893.6 7913.3 7963.2 7735.5 7773.8 7900.8 7936.2 7939.2 7187.2 7573.4 7597.0 7625.0 7662.9 24240.6 29641.7 30131.7 30182.7 30207.8 2530.4 2622.2 2630.1 2713.7 3185.7 12954.6 14158.9 17123.6 17615.8 17917.3 2012.3 2016.9 2050.6 2060.9 2062.9 150961.2 151657.0 153567.0 153608.0 155955.0 21098.5 21837.0 21856.1 22230.6 22404.9 36986.0 36993.8 37049.5 37049.8 37197.0 10747.4 10956.7 11051.9 11057.8 11353.7 7307.3 7439.7 8997.8 9051.6 9239.6 9846.8 9934.1 9976.3 9990.5 10113.6 3199.4 3211.8 3684.9 3805.9 3818.6 901.0 937.8 945.6 977.0 988.5 20888.0 21442.5 22008.7 22058.4 22200.6 909.5 934.4 938.2 959.8 1037.4 10835.2 11259.5 11601.1 11634.4 11688.9 632970.0 635582.0 636325.0 638780.0 654463.0 109340.5 131510.0 132422.0 144047.6 145581.0 823.8 947.3 992.2 1007.1 1012.0 18568.9 19473.8 19513.5 19570.6 19600.9 45894.5 59658.0 59737.0 60718.1 60755.0 84510.0 85217.0 87238.6 87768.6 87904.6 7722.1 8026.3 8136.7 8262.3 8506.2 12880.0 13388.6 13460.3 13477.0 14086.8 11534.6 11572.8 11949.3 12010.8 12086.5 9342.4 11643.8 11902.1 11997.9 11999.7 11666.4 11771.6 11993.5 12109.0 12188.4 8194.0 8217.0 8508.3 8652.0 8681.6 11319.1 11552.5 11585.2 11996.9 12039.9 05:54:31 INFO - PROCESS | 1658 | 05:54:31 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5774.59 Median:4719.47 stddev:3226.83 (68.4%) stddev-sans-first:3220.56 05:54:31 INFO - PROCESS | 1658 | Values: 1590.3 1627.5 1848.8 1944.7 1961.3 8752.3 9207.7 9210.4 9225.5 9227.4 7960.4 8212.2 8223.6 8591.4 8988.6 2352.5 2395.3 2397.2 2406.9 2408.9 2360.2 2384.3 2393.9 2398.9 2402.8 2093.8 2312.6 2378.3 2389.0 2402.3 2386.0 2405.7 2408.6 2408.9 2409.3 2375.3 2390.3 2397.5 2401.6 2401.8 7729.3 9101.0 9183.8 9185.5 9185.5 5275.2 5375.6 5426.6 5446.2 5458.7 3525.6 3545.5 3615.9 3702.5 3702.6 1079.9 1083.3 1091.7 1095.7 1113.2 11739.8 11918.0 11955.2 11957.3 11959.0 4595.4 4641.5 4797.4 4828.7 4829.5 10118.8 10123.1 10124.4 10132.7 10138.4 5413.2 5414.5 5419.3 5423.1 5428.2 3610.8 4342.9 4590.1 4962.4 4965.1 3949.5 3988.6 4011.7 4057.0 4096.1 1277.1 1281.0 1284.6 1297.1 1297.7 644.7 820.3 922.8 962.2 983.0 5927.8 5998.3 6004.1 6028.6 6052.9 864.3 980.5 980.8 993.6 1009.7 3523.5 4054.9 4168.9 4170.2 4170.2 10329.2 10443.3 10480.0 10855.2 10869.1 10801.8 10815.6 10817.4 10819.2 10826.8 8151.1 8272.1 8272.3 8342.8 8352.5 5815.6 5922.4 6012.9 6055.0 6064.1 10054.4 10113.1 10150.9 10151.9 10179.0 10021.4 10088.5 10105.2 10199.5 10323.3 7348.1 7520.0 7526.7 7534.7 7549.4 8146.6 8270.5 8320.5 8353.7 8368.0 7447.6 7449.1 7512.7 7544.4 7603.5 7297.9 7378.2 7399.9 7491.6 7513.2 6989.0 7029.2 7145.2 7151.8 7157.7 4895.2 4980.4 5014.6 5024.8 5172.9 4977.3 5030.2 5051.7 5102.6 5233.5 05:54:31 INFO - PROCESS | 1658 | 05:54:31 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4489.21 Median:4875.02 stddev:1367.76 (28.1%) stddev-sans-first:1334.98 05:54:31 INFO - PROCESS | 1658 | Values: 300.8 304.9 311.9 315.5 316.6 4628.8 5379.8 5556.9 5577.8 5631.9 5205.1 5304.0 5534.6 5554.2 5604.4 4215.7 4221.7 4222.7 4264.3 4277.0 3893.0 4098.7 4206.3 4267.0 4277.7 3948.0 4103.9 4211.5 4217.0 4248.7 4203.8 4208.9 4234.4 4241.8 4269.1 3167.9 3674.2 3680.4 3680.7 3686.4 4966.3 5359.5 5397.4 5418.7 5454.9 4403.4 4840.2 4854.3 4860.6 4872.6 4935.9 5530.2 5543.3 5862.2 5934.5 3596.9 3789.9 3801.6 3999.5 4041.5 5859.6 6115.8 6199.3 6204.8 6229.3 3800.7 3936.1 4096.0 4117.2 4122.5 3203.8 4135.8 4135.9 4177.5 4197.2 4754.5 4824.5 4832.0 4871.8 4896.4 5552.8 5793.6 5851.0 5893.6 5937.9 1168.8 1290.4 1425.4 1428.8 1433.4 827.3 837.6 876.3 890.6 897.2 3995.6 4185.1 4558.8 4652.7 4671.5 3972.4 4648.4 5062.7 5085.6 5099.0 4061.4 4108.9 4628.2 4645.4 4654.8 2305.6 2476.0 2535.0 2670.7 2695.2 5199.1 5247.6 5253.6 5257.9 5296.6 4877.5 4962.5 5200.6 5251.5 5282.9 4704.3 4775.0 4818.5 5237.3 5342.8 4133.3 4515.3 4919.3 5102.3 5126.8 4029.9 4608.7 5008.4 5017.6 5057.0 4449.7 4971.4 5024.7 5225.9 5244.8 3615.7 3631.9 3859.5 3956.9 4045.3 4946.0 5099.5 5224.6 5694.3 5894.8 4711.0 5753.8 5809.9 5824.9 5841.0 5537.8 5793.4 5854.2 5913.6 5938.7 5010.0 5656.9 5813.2 5825.9 5830.2 5706.8 5940.9 5961.9 6026.9 6031.3 5001.0 5653.8 5734.5 5761.6 5774.6 05:54:31 INFO - PROCESS | 1658 | 05:54:31 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:24937.46 Median:23065.31 stddev:39025.74 (169.2%) stddev-sans-first:39092.92 05:54:31 INFO - PROCESS | 1658 | Values: 738.2 746.7 769.0 801.0 848.3 15139.4 16380.3 16406.2 16407.3 16434.4 14798.7 14952.9 14962.3 14981.8 15011.3 710.9 733.9 865.5 870.7 901.8 890.2 891.0 897.0 897.4 898.1 870.4 885.5 952.4 953.1 959.2 735.3 927.4 945.2 947.7 948.2 707.4 714.7 716.4 717.1 718.7 15086.2 15121.9 15130.1 15134.2 15160.9 14145.7 14284.7 14349.5 14356.9 14502.9 12879.8 13121.3 13122.7 13400.0 13640.9 3957.8 4619.9 4672.4 4803.6 4842.3 116349.0 117647.0 117904.4 119570.4 123009.0 11192.2 11254.8 11360.4 11844.2 11945.0 23000.3 23049.8 23055.4 23075.2 23105.2 7989.9 8030.5 8149.9 8335.1 8381.5 4373.3 4501.6 4503.8 4564.3 4669.8 3382.3 3491.4 3494.4 3495.5 3500.1 548.5 637.4 646.0 650.8 657.3 554.7 599.3 603.9 619.6 664.5 6847.0 7608.8 9027.3 9157.3 9218.4 586.4 630.1 642.2 643.4 647.8 3988.3 4069.3 4584.1 4674.7 4713.1 113867.0 120659.0 124523.8 152390.0 170206.0 103293.9 110880.9 128553.7 131427.0 133748.0 95645.5 111476.9 113124.0 113647.4 121846.0 8084.3 10005.7 10176.8 10230.8 10237.7 53158.0 61697.4 63981.7 64654.0 65319.3 90660.6 94466.0 96495.5 97794.0 99661.0 13011.4 13451.3 13481.5 13865.2 14021.4 15084.2 15304.2 15365.0 16088.5 16115.2 14078.1 14184.1 14189.9 14318.0 14425.9 14159.9 14171.7 14180.0 14272.0 14823.5 13630.6 13768.2 14004.8 14155.2 14222.9 10976.0 11292.7 11387.2 11416.1 11460.8 10155.9 10287.8 10555.8 11134.7 11379.0 05:54:31 INFO - PROCESS | 1658 | -------- Summary: end -------- 05:54:31 INFO - PROCESS | 1658 | 05:54:32 INFO - TEST-INFO | 1658: exit 0 05:54:32 INFO - TEST-OK | dromaeo_css | took 1116185ms 05:54:32 INFO - TEST-START | kraken 05:54:32 INFO - operating with platform_type : mac_ 05:54:32 INFO - Initialising browser for kraken test... 05:54:32 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpnqM1nv/profile http://localhost:49274/getInfo.html) 05:54:34 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 05:54:34 INFO - PROCESS | 1664 | colorDepth:24 05:54:34 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 05:54:34 INFO - PROCESS | 1664 | __metrics 05:54:34 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:54:34 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:54:35 INFO - TEST-INFO | 1664: exit 0 05:54:35 INFO - Browser initialized. 05:54:35 INFO - Running cycle 1/1 for kraken test... 05:54:35 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpnqM1nv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:47 INFO - PROCESS | 1666 | RSS: Main: 245469184 05:54:47 INFO - PROCESS | 1666 | 05:54:49 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 05:54:50 INFO - PROCESS | 1666 | RSS: Main: 294637568 05:54:50 INFO - PROCESS | 1666 | 05:54:53 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 05:54:54 INFO - PROCESS | 1666 | RSS: Main: 305692672 05:54:54 INFO - PROCESS | 1666 | 05:54:57 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 05:54:58 INFO - PROCESS | 1666 | RSS: Main: 389910528 05:54:58 INFO - PROCESS | 1666 | 05:55:00 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 05:55:00 INFO - PROCESS | 1666 | RSS: Main: 291831808 05:55:00 INFO - PROCESS | 1666 | 05:55:02 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:55:03 INFO - PROCESS | 1666 | RSS: Main: 295596032 05:55:03 INFO - PROCESS | 1666 | 05:55:06 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 05:55:06 INFO - PROCESS | 1666 | RSS: Main: 332070912 05:55:06 INFO - PROCESS | 1666 | 05:55:09 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 05:55:10 INFO - PROCESS | 1666 | RSS: Main: 336207872 05:55:10 INFO - PROCESS | 1666 | 05:55:13 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 05:55:13 INFO - PROCESS | 1666 | RSS: Main: 335138816 05:55:13 INFO - PROCESS | 1666 | 05:55:15 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:55:16 INFO - PROCESS | 1666 | RSS: Main: 314355712 05:55:16 INFO - PROCESS | 1666 | 05:55:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:55:18 INFO - PROCESS | 1666 | RSS: Main: 321019904 05:55:18 INFO - PROCESS | 1666 | 05:55:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:55:21 INFO - PROCESS | 1666 | RSS: Main: 319074304 05:55:21 INFO - PROCESS | 1666 | 05:55:24 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:55:24 INFO - PROCESS | 1666 | RSS: Main: 327532544 05:55:24 INFO - PROCESS | 1666 | 05:55:27 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:55:28 INFO - PROCESS | 1666 | RSS: Main: 329068544 05:55:28 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 05:55:30 INFO - PROCESS | 1666 | RSS: Main: 372465664 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | __start_tp_report 05:55:30 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 05:55:30 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 05:55:30 INFO - PROCESS | 1666 | |i|pagename|runs| 05:55:30 INFO - PROCESS | 1666 | |0;ai-astar;102;111;113;111;113;112;113;112;111;112 05:55:30 INFO - PROCESS | 1666 | |1;audio-beat-detection;145;106;109;199;133;108;128;103;142;106 05:55:30 INFO - PROCESS | 1666 | |2;audio-dft;184;184;183;182;184;182;182;184;184;185 05:55:30 INFO - PROCESS | 1666 | |3;audio-fft;78;74;58;88;58;57;58;68;82;56 05:55:30 INFO - PROCESS | 1666 | |4;audio-oscillator;82;70;99;72;85;68;98;70;68;103 05:55:30 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;88;85;88;85;88;85;90;85;88;84 05:55:30 INFO - PROCESS | 1666 | |6;imaging-darkroom;95;93;103;144;94;94;94;95;95;94 05:55:30 INFO - PROCESS | 1666 | |7;imaging-desaturate;96;112;84;86;86;107;138;139;86;86 05:55:30 INFO - PROCESS | 1666 | |8;json-parse-financial;53;53;52;53;53;52;53;53;53;51 05:55:30 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;67;78;71;71;77;74;70;72;71;71 05:55:30 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;82;85;85;82;80;85;82;82;82;83 05:55:30 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;148;147;147;136;134;134;133;135;176;138 05:55:30 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;163;162;162;161;166;161;187;163;161;224 05:55:30 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;67;67;65;64;65;65;65;66;66;66 05:55:30 INFO - PROCESS | 1666 | __end_tp_report 05:55:30 INFO - PROCESS | 1666 | __start_cc_report 05:55:30 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,2066 05:55:30 INFO - PROCESS | 1666 | __end_cc_report 05:55:30 INFO - PROCESS | 1666 | __startTimestamp1469105730312__endTimestamp 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | ------- Summary: start ------- 05:55:30 INFO - PROCESS | 1666 | Number of tests: 14 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.27 (2.9%) stddev-sans-first:0.87 05:55:30 INFO - PROCESS | 1666 | Values: 102.0 111.0 113.0 111.0 113.0 112.0 113.0 112.0 111.0 112.0 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:130.50 stddev:29.64 (22.7%) stddev-sans-first:30.78 05:55:30 INFO - PROCESS | 1666 | Values: 145.0 106.0 109.0 199.0 133.0 108.0 128.0 103.0 142.0 106.0 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.07 (0.6%) stddev-sans-first:1.12 05:55:30 INFO - PROCESS | 1666 | Values: 184.0 184.0 183.0 182.0 184.0 182.0 182.0 184.0 184.0 185.0 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:67.70 Median:71.00 stddev:12.00 (16.9%) stddev-sans-first:12.14 05:55:30 INFO - PROCESS | 1666 | Values: 78.0 74.0 58.0 88.0 58.0 57.0 58.0 68.0 82.0 56.0 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:81.50 Median:77.00 stddev:14.03 (18.2%) stddev-sans-first:14.88 05:55:30 INFO - PROCESS | 1666 | Values: 82.0 70.0 99.0 72.0 85.0 68.0 98.0 70.0 68.0 103.0 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:88.00 stddev:2.01 (2.3%) stddev-sans-first:2.07 05:55:30 INFO - PROCESS | 1666 | Values: 88.0 85.0 88.0 85.0 88.0 85.0 90.0 85.0 88.0 84.0 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:100.10 Median:94.00 stddev:15.68 (16.7%) stddev-sans-first:16.52 05:55:30 INFO - PROCESS | 1666 | Values: 95.0 93.0 103.0 144.0 94.0 94.0 94.0 95.0 95.0 94.0 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:102.00 Median:86.00 stddev:21.54 (25.0%) stddev-sans-first:22.73 05:55:30 INFO - PROCESS | 1666 | Values: 96.0 112.0 84.0 86.0 86.0 107.0 138.0 139.0 86.0 86.0 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 05:55:30 INFO - PROCESS | 1666 | Values: 53.0 53.0 52.0 53.0 53.0 52.0 53.0 53.0 53.0 51.0 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:71.50 stddev:3.29 (4.6%) stddev-sans-first:2.91 05:55:30 INFO - PROCESS | 1666 | Values: 67.0 78.0 71.0 71.0 77.0 74.0 70.0 72.0 71.0 71.0 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:1.69 (2.0%) stddev-sans-first:1.76 05:55:30 INFO - PROCESS | 1666 | Values: 82.0 85.0 85.0 82.0 80.0 85.0 82.0 82.0 82.0 83.0 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:142.50 stddev:13.10 (9.2%) stddev-sans-first:13.76 05:55:30 INFO - PROCESS | 1666 | Values: 148.0 147.0 147.0 136.0 134.0 134.0 133.0 135.0 176.0 138.0 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:163.00 stddev:20.22 (12.4%) stddev-sans-first:21.24 05:55:30 INFO - PROCESS | 1666 | Values: 163.0 162.0 162.0 161.0 166.0 161.0 187.0 163.0 161.0 224.0 05:55:30 INFO - PROCESS | 1666 | 05:55:30 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:0.88 05:55:30 INFO - PROCESS | 1666 | Values: 67.0 67.0 65.0 64.0 65.0 65.0 65.0 66.0 66.0 66.0 05:55:30 INFO - PROCESS | 1666 | -------- Summary: end -------- 05:55:30 INFO - PROCESS | 1666 | 05:55:31 INFO - TEST-INFO | 1666: exit 0 05:55:31 INFO - TEST-OK | kraken | took 58940ms 05:55:31 INFO - SUITE-END | took 1175s 05:55:31 INFO - Completed test suite (00:19:35) 05:55:31 INFO - javascript benchmark 05:55:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3347.1966727985287, 3362.5124356968226, 3370.191154123011, 3372.9325413491724, 3438.9312213755725, 5584.301962254718, 5673.319201695802, 5680.403557626447, 5742.598018138732, 5789.652620842747, 5685.630434021786, 5690.60165788394, 5803.912941305874, 5818.5926985111055, 5822.592418530705, 5148.304978827848, 5206.401263854648, 5207.036698210824, 5211.765470553815, 5318.069337865877, 5346.866328341784, 5350.678959262456, 5359.919601205985, 5371.623986320959, 5383.16560933054, 5133.230015497668, 5193.974030129825, 5194.194899790538, 5235.240890070937, 5279.656822306538, 5159.793608255665, 5222.869428264324, 5256.395514515842, 5258.211268309784, 5266.15741481365, 5155.561777248939, 5191.6625419348, 5199.038177937094, 5257.658252213594, 5276.947230527684, 5729.0260655688635, 5749.0801471764735, 5763.366029736726, 5815.825525234208, 5831.970840145772, 6090.0, 6136.1821086261625, 6246.0, 6255.906161407583, 6283.497320214372, 5580.637258578179, 6265.530085243625, 6297.0, 6323.7786677466065, 6326.715297811609, 5854.765809367663, 5888.499477544414, 5912.852178695524, 5918.348981612019, 5920.171176035358, 6128.356522565066, 6250.0, 6255.74977000924, 6280.183576135073, 6287.402696743802, 6099.43084549468, 6166.105914642351, 6182.69086545671, 6184.6598437085495, 6196.256449226122, 6293.3391993840905, 6301.8109456716375, 6309.716062777186, 6311.936880631227, 6317.96841015792, 6084.969575152184, 6109.175261339751, 6248.656323902229, 6254.34329395416, 6270.7491700331475, 5130.563902068366, 6155.353687862799, 6183.628982261079, 6185.567010309235, 6189.133521307021, 4922.803087876445, 4971.477994810565, 4972.5027497249985, 5004.84985450437, 5020.322256495327, 4465.665075119379, 4467.56517697849, 4469.2849144137435, 4476.171908196994, 4513.50351461339, 5726.77092916287, 5789.913151302734, 5792.0, 5801.564882633819, 5857.179994800731, 6144.972159187458, 6188.009918413032, 6204.968975155095, 6275.466585340298, 6288.9056664150075, 5733.942660573424, 5760.481556659921, 5788.3343415506915, 5797.449242321973, 5797.797077102281, 5407.540359069444, 5461.453854614507, 5470.398256191816, 5477.04151773438, 5490.066688662937, 5976.282846058414, 6273.404026617464, 6279.96860015697, 6282.591631543935, 6297.653629050446, 5192.324997750268, 6099.309783606499, 6182.876342473215, 6201.441870231701, 6318.810435686937, 6277.309495955533, 6282.623042617458, 6283.528735344776, 6290.9056364155485, 6294.937050629435, 5252.632315737862, 6144.815655530341, 6213.409726076015, 6243.125962365363, 6243.96878015607, 5670.036093864135, 6140.508759299156, 6176.722047507783, 6234.937650623436, 6306.9684651576445, 5533.501984821385, 6137.9693101535995, 6149.41580549847, 6152.50779937595, 6164.7842325518395, 5113.590912727047, 6118.921295324959, 6128.655903792168, 6132.386761323832, 6138.539609529393, 5813.447722466359, 5867.295924489089, 5882.058870580687, 5922.703864806828, 5942.257217847769, 6109.780439121757, 6140.078988151813, 6149.477294429845, 6157.9384206157365, 6165.383461653978, 5918.053111502139, 5967.9701601491715, 5971.193888825127, 5975.611585246945, 6004.129401236709], "value": 5697.848535420817, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.2381116419788, 520.5159201942193, 521.3144714700171, 525.3564383630054, 568.173307837097, 30531.847340763292, 41162.79418602907, 41957.0, 42066.57933420669, 44147.77926110365, 43480.56519434813, 43812.780936095274, 43869.12261754771, 43910.56089439105, 43919.56080439195, 9776.315657903931, 9980.401175929432, 9984.151347135503, 9987.201023918105, 9992.650257240997, 8790.16493433126, 9020.41367311126, 12035.0, 12248.020158387308, 12254.81617775734, 12217.20588161771, 12265.816012759815, 12276.263424194532, 12279.69300767479, 12292.508299668003, 12174.330411827346, 12249.632511024683, 12258.693532661666, 12267.3252971087, 12274.509019639203, 8795.736127916172, 9002.504862232574, 9002.594883230206, 9098.317626178063, 11822.645320640395, 32181.517277240626, 41300.0, 41690.58309416928, 41693.37459938104, 41763.0, 3495.667911548399, 3554.3424466473525, 3584.032311275941, 3705.184859330943, 3852.9422058669143, 31168.8441557793, 31394.37211255762, 32426.0, 32445.675543244502, 32447.837760811046, 3298.0765385692043, 3368.3768502827056, 3399.8810041648426, 3404.5914490261325, 3438.5529881115544, 532969.9999999962, 534296.0, 535212.0, 536532.0, 537078.0, 60547.789044218865, 60682.69658651767, 60720.0, 60784.08823867646, 60916.0, 64485.67757161184, 64625.03062454067, 64738.0, 64743.67628161829, 64826.0, 16315.1026693533, 16493.257803398876, 16540.917295413445, 16573.91713041427, 16663.0, 9634.277429192838, 11808.232464889927, 11834.289942603471, 12013.219140755822, 12036.75926481483, 16380.26288817006, 16792.99242045481, 16801.663966720596, 16941.0, 17207.1396430178, 6073.96963015191, 6723.189939056136, 6810.455163587, 6880.346367095118, 6906.171259448798, 821.7247222180637, 885.9778505537284, 916.2852974679761, 965.6137544982064, 1015.0914931136739, 28065.71934280672, 29516.852415737783, 29559.704402956126, 30286.242843928638, 30398.848005759828, 1007.3351587951917, 1025.4052649463292, 1075.575147816608, 1078.7626722121122, 1121.9439028048728, 13615.455381784815, 15467.381304747909, 15916.283767230503, 15966.647004129263, 16390.754138687927, 688151.0, 694856.0, 695079.0, 695877.0, 698159.0, 52430.737846311284, 59714.70142649259, 59757.701211493666, 59783.40216597865, 59878.802423951274, 1259.5024965138718, 1275.6300672804969, 1316.8617295183867, 1328.7076843094503, 1428.164523753595, 27812.30469238285, 28652.28369290701, 32249.0, 32617.836910815295, 32732.836335818167, 55332.0, 56039.0, 56149.71925140348, 56191.43808561862, 56208.0, 640575.0, 649028.0, 649618.0, 649920.0, 650205.0, 34524.0, 38254.42618360671, 40775.0, 41110.794446027576, 42270.57729422666, 46255.07489850117, 47391.0, 47650.76174619105, 48270.0, 48301.516984831105, 39161.41257881077, 39342.606573933896, 39577.604223957394, 40355.59644403518, 40693.79653101716, 38738.837834865, 38888.222235555695, 39658.80170599128, 40576.0, 40621.390679139244, 38242.6175738239, 38543.614563855124, 38633.42049869311, 39142.02144946399, 39306.213875721754, 32684.50973235356, 34723.95628665378, 34777.0, 34842.0, 34980.30039399249, 25610.10364637229, 25738.4556926585, 26146.215613531625, 26332.8683356582, 26533.33666658349], "value": 20790.9154926072, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.4891529570362, 360.81237756366704, 377.84697197634966, 394.38475977475133, 412.7358490566036, 15587.610309742262, 15608.531744047683, 20285.47858910584, 20478.28326008592, 20512.794872051276, 20763.857987810665, 21356.679649805264, 21369.465763355925, 22999.655005174936, 23807.28578142654, 6606.8678626427445, 6665.966670166642, 6852.314768523158, 6940.13248343957, 6967.895481567781, 4574.908501829961, 6753.628550429725, 6860.5540639858245, 6860.862782744342, 6866.690998905061, 7475.551466911976, 7803.921960780404, 7893.565853878034, 7913.28780409763, 7963.203679632019, 7735.535867847919, 7773.766786996399, 7900.841983160304, 7936.246056624612, 7939.206079392073, 7187.209406965229, 7573.431992600577, 7596.962015189889, 7624.961875190644, 7662.923370766277, 24240.636390454158, 29641.703582964325, 30131.69868301333, 30182.69817301821, 30207.848960755055, 2530.4433024734712, 2622.2002289301754, 2630.118910165097, 2713.72862713729, 3185.729213016896, 12954.611361659165, 14158.929205353907, 17123.57191070221, 17615.823841761547, 17917.283308667636, 2012.2655230840637, 2016.90923908423, 2050.5693804301113, 2060.917563297466, 2062.886541240231, 150961.24519377333, 151657.0, 153567.0, 153608.0, 155954.99999999886, 21098.47253818636, 21837.0, 21856.125754969624, 22230.55538889213, 22404.887975560017, 36986.0, 36993.81503092521, 37049.518019279465, 37049.81475092661, 37197.0, 10747.40889251083, 10956.726081848017, 11051.944740276407, 11057.834132488018, 11353.716157095974, 7307.3423391894985, 7439.739609113655, 8997.775055623662, 9051.597002464629, 9239.584218710039, 9846.803063938682, 9934.105930466292, 9976.251781116445, 9990.450525221182, 10113.595456181818, 3199.40810949975, 3211.823349715741, 3684.889453316405, 3805.942910856284, 3818.560865500503, 901.0, 937.8358787212347, 945.5886689290181, 976.9951150244345, 988.4859872866069, 20888.0, 21442.463938401354, 22008.669869951962, 22058.44853878666, 22200.555988880133, 909.4770506958525, 934.4440058165517, 938.1744065222697, 959.7744530035436, 1037.387941114731, 10835.241533092609, 11259.549618015351, 11601.099725068732, 11634.36011019402, 11688.883111168949, 632970.0, 635582.0, 636325.0, 638780.0, 654463.0, 109340.45329773301, 131510.0, 132422.0, 144047.55952440551, 145581.0, 823.8187598728271, 947.2564037230741, 992.1517102876936, 1007.0634310091685, 1012.0486742462062, 18568.907155464676, 19473.83157010584, 19513.512162196057, 19570.60858782845, 19600.9019954905, 45894.541054589026, 59658.0, 59737.0, 60718.08922866249, 60755.0, 84510.0, 85217.0, 87238.56380718056, 87768.56115719635, 87904.5604771972, 7722.111957125003, 8026.317762990211, 8136.696501220429, 8262.256396924306, 8506.191911768372, 12879.969602431596, 13388.598342049365, 13460.326983650973, 13477.0, 14086.788698169741, 11534.59628912984, 11572.826407603725, 11949.283043017447, 12010.819837702267, 12086.45610947527, 9342.439453632804, 11643.825342619699, 11902.107341949562, 11997.940010300243, 11999.700007499883, 11666.416679165837, 11771.646850594154, 11993.460294286604, 12109.0, 12188.390580470763, 8193.959030204811, 8217.0, 8508.27679647237, 8652.048274689905, 8681.609327580149, 11319.09447244202, 11552.480138393961, 11585.246958947642, 11996.940015299868, 12039.939800300943], "value": 11365.081176249292, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1590.3479573374916, 1627.462937230714, 1848.8151184881513, 1944.6791279438894, 1961.264525802823, 8752.29981601472, 9207.67773127939, 9210.447373157607, 9225.538723063837, 9227.446353218804, 7960.402969777261, 8212.1787821218, 8223.588820558964, 8591.441556298836, 8988.595513201904, 2352.458934445074, 2395.3412811476896, 2397.1729753235104, 2406.8916898739512, 2408.915687950922, 2360.1975328388344, 2384.2847145856263, 2393.8803059847023, 2398.868062256584, 2402.8077753779744, 2093.811556959873, 2312.5721741477882, 2378.2746262389965, 2388.976110238893, 2402.327348342458, 2386.0217310902535, 2405.6992875890514, 2408.5664580375615, 2408.903643854261, 2409.3133456964856, 2375.2755409600063, 2390.2829151254728, 2397.520495900827, 2401.579723548372, 2401.795847352977, 7729.34300584451, 9100.99889012208, 9183.816323673556, 9185.49479778612, 9185.49479778612, 5275.235090911796, 5375.596830237709, 5426.593005524562, 5446.210299506589, 5458.699771512565, 3525.594556625995, 3545.503629491873, 3615.94576081359, 3702.4631428442995, 3702.611225821277, 1079.9028087472166, 1083.2796190533286, 1091.730267847793, 1095.6986828622114, 1113.204059097749, 11739.823902641467, 11917.986971107466, 11955.222910510876, 11957.282563046245, 11959.043276537943, 4595.356650068993, 4641.535846415399, 4797.40032495938, 4828.686135401188, 4829.492903245179, 10118.848217276747, 10123.139533139618, 10124.443155626512, 10132.746681333025, 10138.442385668859, 5413.188021796684, 5414.512693857571, 5419.295491586068, 5423.078076726966, 5428.158635411518, 3610.819459027038, 4342.891427714332, 4590.127875703605, 4962.354893863775, 4965.131102057126, 3949.4668219790533, 3988.6011398859882, 4011.6590089842107, 4057.0323393154295, 4096.1193343431305, 1277.1060257819563, 1280.9679758006125, 1284.621036794148, 1297.0531511996107, 1297.740451909622, 644.7388807532957, 820.33552822213, 922.7508572685338, 962.2206013129247, 983.026803464565, 5927.792527261525, 5998.25021872266, 6004.129401236796, 6028.638281703112, 6052.909206361908, 864.2696921101659, 980.5391466010964, 980.8234517786724, 993.64228877604, 1009.707184916366, 3523.524324216249, 4054.8580799671868, 4168.91662166761, 4170.22850772608, 4170.249355116048, 10329.173666106693, 10443.268971171945, 10480.0, 10855.2401331906, 10869.130469562417, 10801.78396432067, 10815.567377304977, 10817.405042722568, 10819.18856085781, 10826.783464330827, 8151.144129866398, 8272.131426200162, 8272.33821294295, 8342.833143337099, 8352.498850069016, 5815.5929084963645, 5922.407759224043, 6012.909806352821, 6054.969725151346, 6064.090386442069, 10054.396736195558, 10113.14038306752, 10150.949245253727, 10151.898481015096, 10179.03299186576, 10021.448820314952, 10088.495575221357, 10105.19158467306, 10199.490025498844, 10323.32898361604, 7348.081489813773, 7519.962400188183, 7526.661300241392, 7534.736284230025, 7549.433792465697, 8146.5519396433765, 8270.462419942685, 8320.542370169698, 8353.749387518385, 8367.95816020916, 7447.5531468112085, 7449.106107267163, 7512.699492020258, 7544.358729508053, 7603.505772124794, 7297.890531642136, 7378.167156155238, 7399.889001664872, 7491.625418729151, 7513.173550909286, 6988.965055174692, 7029.226785053538, 7145.21402645719, 7151.7854464366155, 7157.7136914522835, 4895.1922932717125, 4980.402351717817, 5014.648974571745, 5024.799008039638, 5172.948270517247, 4977.278294647328, 5030.220315851049, 5051.6716413433005, 5102.591792656653, 5233.450487698889], "value": 4648.307858821968, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.76540298567124, 304.9496833022551, 311.8658976640045, 315.45583867827986, 316.6232183701395, 4628.791704373303, 5379.8386048418515, 5556.91664625031, 5577.832665020051, 5631.943680563193, 5205.063088644042, 5304.0, 5534.612577119593, 5554.166874968757, 5604.439556044394, 4215.704900656955, 4221.662267018646, 4222.68329875259, 4264.2537555927665, 4277.0, 3893.0462036801023, 4098.692598055143, 4206.305959516676, 4266.954596123954, 4277.716684994505, 3947.960520394802, 4103.8563650272245, 4211.473565804275, 4216.9578304216875, 4248.660107191417, 4203.831846726127, 4208.936865947013, 4234.449521562208, 4241.7879106044575, 4269.124829409994, 3167.857446414917, 3674.173311005029, 3680.405314253445, 3680.6687398134027, 3686.3548878946076, 4966.329545511346, 5359.517643412111, 5397.379301380352, 5418.7019713915715, 5454.863628409322, 4403.427554417937, 4840.15297322967, 4854.271859221145, 4860.562549370574, 4872.585830204437, 4935.901281974377, 5530.170474428827, 5543.309290666385, 5862.186150647671, 5934.465898069195, 3596.946045809315, 3789.905252368685, 3801.619838016204, 3999.5200575930785, 4041.5150181978056, 5859.589828711992, 6115.785947491817, 6199.349068347804, 6204.81385558434, 6229.31477537466, 3800.6959443245028, 3936.0553467167674, 4095.97952010244, 4117.155983023473, 4122.546519882811, 3203.7757356985253, 4135.813888375031, 4135.855245066408, 4177.456930599003, 4197.202531519001, 4754.5245475452175, 4824.517548245218, 4831.975840120847, 4871.756412179377, 4896.387951506062, 5552.805651802168, 5793.594448388572, 5850.970745146247, 5893.5579831512805, 5937.940620593825, 1168.807146820782, 1290.4386591832583, 1425.3657122580353, 1428.8356838963653, 1433.376481230668, 827.3422629009951, 837.5937670229933, 876.3077169036517, 890.6036813618007, 897.241830653097, 3995.6004399560393, 4185.100203456272, 4558.766204559742, 4652.743759185001, 4671.462781780071, 3972.3842804365368, 4648.442186937589, 5062.721550314768, 5085.64400491962, 5098.974505127525, 4061.3501839706096, 4108.931677763803, 4628.236341003764, 4645.372874661945, 4654.767261636973, 2305.561943230781, 2476.0, 2534.961975570368, 2670.692870319899, 2695.245331307237, 5199.0641684496395, 5247.606429517801, 5253.632245742761, 5257.947420525746, 5296.576273898079, 4877.463479017305, 4962.478939711351, 5200.583953283728, 5251.52736253739, 5282.920756188661, 4704.270838020112, 4774.976125119352, 4818.494058123846, 5237.319148510745, 5342.813001544927, 4133.305344808614, 4515.2549829277805, 4919.286703428054, 5102.265229821878, 5126.820561280338, 4029.9395509066803, 4608.700434471749, 5008.373953255843, 5017.591556053042, 5057.0, 4449.733016018919, 4971.37857767779, 5024.683708752206, 5225.9216111759115, 5244.842654720212, 3615.6565126312958, 3631.854725810938, 3859.4789703389683, 3956.931628460242, 4045.271851066836, 4945.97527012377, 5099.515546023122, 5224.60815438836, 5694.345150307768, 5894.764209431574, 4710.974281059178, 5753.827385178452, 5809.9419005809405, 5824.912626310524, 5840.984860223216, 5537.750801213874, 5793.449622285876, 5854.209681692917, 5913.615614985012, 5938.703064846654, 5010.0, 5656.88686226265, 5813.186153938536, 5825.883482330245, 5830.183774271521, 5706.828795136153, 5940.940590594038, 5961.8807623846415, 6026.8794624106395, 6031.276246850406, 5000.974995125001, 5653.756173641792, 5734.54123670097, 5761.596688231783, 5774.585226619505], "value": 4054.0924843738403, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.1953670499156, 746.6751962896141, 769.0348612491323, 801.0107517216237, 848.2747251100313, 15139.394424223032, 16380.262888170031, 16406.179691015463, 16407.343706251737, 16434.424795132174, 14798.704025919475, 14952.925235373836, 14962.251887405613, 14981.775273370908, 15011.32449039793, 710.9253528379523, 733.9009233753455, 865.5239618209976, 870.6647940542873, 901.7790641292893, 890.1765866573394, 890.9821803563925, 897.0177655467253, 897.407710910799, 898.137787723786, 870.4168207301124, 885.4946590795673, 952.4095061062117, 953.0659953245823, 959.1751094059103, 735.3235023778137, 927.429630777074, 945.2390825385596, 947.7109481608106, 948.2035090523958, 707.4305184326615, 714.653393104344, 716.3767522255619, 717.0892965933288, 718.7268837841639, 15086.17026063577, 15121.941464097517, 15130.092194468367, 15134.243287835674, 15160.938734288604, 14145.717085658333, 14284.714305713931, 14349.497767578188, 14356.856431435657, 14502.927485362507, 12879.806802897963, 13121.343932803416, 13122.671933201651, 13400.0, 13640.93179534106, 3957.7823219722904, 4619.884502887421, 4672.3692301539195, 4803.567678908915, 4842.346283251786, 116348.99999999916, 117647.0, 117904.41047794792, 119570.4021479887, 123009.0, 11192.216544841784, 11254.774904502028, 11360.431978401048, 11844.170908036354, 11945.044396448264, 23000.309990700305, 23049.769502304764, 23055.42361440944, 23075.19236826703, 23105.19131830378, 7989.880151797728, 8030.478018928751, 8149.878695300561, 8335.083140854502, 8381.539015354214, 4373.2565463871215, 4501.572350626685, 4503.842365517191, 4564.292534657134, 4669.836555720602, 3382.2728113455723, 3491.389006923778, 3494.3884820156372, 3495.528103706018, 3500.1074725944723, 548.4707257496456, 637.4454224824433, 645.9580127291711, 650.817771024114, 657.3196741372657, 554.7448173839998, 599.2509363295881, 603.9396060394014, 619.5817822969477, 664.4817042706696, 6847.0, 7608.771736847792, 9027.322950778718, 9157.313201509913, 9218.354715170008, 586.3960121075299, 630.1052505442283, 642.1780121444558, 643.4048505132733, 647.8186107889799, 3988.3419235825763, 4069.348904175318, 4584.106099310669, 4674.672772905864, 4713.057388522309, 113867.0, 120659.0, 124523.75476245122, 152390.0, 170206.0, 103293.93412131866, 110880.89119108867, 128553.71446285417, 131427.0, 133748.0, 95645.5217723907, 111476.88523114665, 113124.0, 113647.43176284232, 121846.0, 8084.312833408991, 10005.699829005142, 10176.796464070825, 10230.795384092426, 10237.744056398351, 53158.0, 61697.38302616916, 63981.68009159924, 64654.0, 65319.34680653323, 90660.64009040002, 94466.0, 96495.51752241194, 97794.0, 99661.0, 13011.414486347947, 13451.260180689764, 13481.524967537413, 13865.23741194244, 14021.439142434188, 15084.170370629721, 15304.234788260765, 15365.0, 16088.517344479684, 16115.194240288172, 14078.084924479876, 14184.078034927697, 14189.929050354682, 14318.0, 14425.927870360581, 14159.858401416266, 14171.716565668836, 14180.0, 14272.00095993312, 14823.481178158712, 13630.591082267549, 13768.24274664903, 14004.78992815129, 14155.221462819643, 14222.8621710265, 10976.0, 11292.679423230196, 11387.202895797545, 11416.086713062768, 11460.770784584094, 10155.949220253851, 10287.794244114926, 10555.841662374916, 11134.665960021212, 11379.0], "value": 7984.651392633731, "unit": "score"}], "name": "dromaeo_css", "value": 7663.761236510993, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 113.0, 111.0, 113.0, 112.0, 113.0, 112.0, 111.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 106.0, 109.0, 199.0, 133.0, 108.0, 128.0, 103.0, 142.0, 106.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 182.0, 184.0, 182.0, 182.0, 184.0, 184.0, 185.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 58.0, 88.0, 58.0, 57.0, 58.0, 68.0, 82.0, 56.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 99.0, 72.0, 85.0, 68.0, 98.0, 70.0, 68.0, 103.0], "value": 81.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 88.0, 85.0, 90.0, 85.0, 88.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 103.0, 144.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 100.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 112.0, 84.0, 86.0, 86.0, 107.0, 138.0, 139.0, 86.0, 86.0], "value": 102.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 53.0, 52.0, 53.0, 53.0, 53.0, 51.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 78.0, 71.0, 71.0, 77.0, 74.0, 70.0, 72.0, 71.0, 71.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 85.0, 82.0, 80.0, 85.0, 82.0, 82.0, 82.0, 83.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 136.0, 134.0, 134.0, 133.0, 135.0, 176.0, 138.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 166.0, 161.0, 187.0, 163.0, 161.0, 224.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1447.2, "alertThreshold": 2.0}]} 05:55:31 INFO - Return code: 0 05:55:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:55:31 INFO - # TBPL SUCCESS # 05:55:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:55:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:55:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:55:31 INFO - 2016-07-21 05:55:31.620 screenresolution[1670:10612] starting screenresolution argv=screenresolution get 05:55:31 INFO - 2016-07-21 05:55:31.623 screenresolution[1670:10612] Display 0: 1600x1200x32@60 05:55:31 INFO - 2016-07-21 05:55:31.629 screenresolution[1671:10615] starting screenresolution argv=screenresolution list 05:55:31 INFO - Available Modes on Display 0 05:55:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:55:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:55:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:55:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:55:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:55:31 INFO - Intel Iris: 05:55:31 INFO - Chipset Model: Intel Iris 05:55:31 INFO - Type: GPU 05:55:31 INFO - Bus: Built-In 05:55:31 INFO - VRAM (Dynamic, Max): 1536 MB 05:55:31 INFO - Vendor: Intel (0x8086) 05:55:31 INFO - Device ID: 0x0a2e 05:55:31 INFO - Revision ID: 0x0009 05:55:31 INFO - Displays: 05:55:31 INFO - Display: 05:55:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:55:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:55:31 INFO - Display Serial Number: 1600x1200 60 05:55:31 INFO - Main Display: Yes 05:55:31 INFO - Mirror: Off 05:55:31 INFO - Online: Yes 05:55:31 INFO - Rotation: Supported 05:55:31 INFO - Return code: 0 05:55:31 INFO - Running post-action listener: _resource_record_post_action 05:55:31 INFO - [mozharness: 2016-07-21 12:55:31.867349Z] Finished run-tests step (success) 05:55:31 INFO - Running post-run listener: _resource_record_post_run 05:55:31 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 31689728; Write bytes: 708185600; Read time: 195; Write time: 1945 05:55:31 INFO - TinderboxPrint: CPU usage
53.6% 05:55:31 INFO - TinderboxPrint: I/O read bytes / time
31,689,728 / 195 05:55:31 INFO - TinderboxPrint: I/O write bytes / time
708,185,600 / 1,945 05:55:31 INFO - TinderboxPrint: CPU idle
2,249.4 (46.4%) 05:55:31 INFO - TinderboxPrint: CPU system
966.2 (19.9%) 05:55:31 INFO - TinderboxPrint: CPU user
1,630.0 (33.6%) 05:55:31 INFO - TinderboxPrint: Swap in / out
436,092,928 / 0 05:55:31 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 401680896; Write bytes: 395863552; Read time: 31060; Write time: 811 05:55:31 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 29654016; Write bytes: 296609792; Read time: 177; Write time: 1090 05:55:32 INFO - Running post-run listener: _upload_blobber_files 05:55:32 INFO - Blob upload gear active. 05:55:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:55:32 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 05:55:32 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'] 05:55:32 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 05:55:32 INFO - (blobuploader) - INFO - Open directory for files ... 05:55:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:55:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:55:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:33 INFO - (blobuploader) - INFO - Done attempting. 05:55:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:55:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:55:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:34 INFO - (blobuploader) - INFO - Done attempting. 05:55:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:55:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:55:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:38 INFO - (blobuploader) - INFO - Done attempting. 05:55:38 INFO - (blobuploader) - INFO - Iteration through files over. 05:55:38 INFO - Return code: 0 05:55:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:55:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:55:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa3cca4f14fd593f031ff42b26e5c9af48b6fe430d138f1eb607c2fa4564a98ecc2c03fb49617df12892c71f637a60a3f0fb199bb6c584056148aeb6a1044407", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48f6039159bbde59e88e47a06a2951ea64666b4af7cabe2c8d260b4ab0f033d133a37b4a054bdfa956b870f30396bd2e14033b7100e7ea9819836f205cb511f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/245188cefc0bf0dd5b313752a312fca5cdca03b5213676830aeddcfd43818f4e16524f7d4afbfd945f6421c83ff09e086b1d3a79baa20a9a4fc7b2461aec4d64"} 05:55:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:55:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:55:38 INFO - Contents: 05:55:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa3cca4f14fd593f031ff42b26e5c9af48b6fe430d138f1eb607c2fa4564a98ecc2c03fb49617df12892c71f637a60a3f0fb199bb6c584056148aeb6a1044407", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48f6039159bbde59e88e47a06a2951ea64666b4af7cabe2c8d260b4ab0f033d133a37b4a054bdfa956b870f30396bd2e14033b7100e7ea9819836f205cb511f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/245188cefc0bf0dd5b313752a312fca5cdca03b5213676830aeddcfd43818f4e16524f7d4afbfd945f6421c83ff09e086b1d3a79baa20a9a4fc7b2461aec4d64"} 05:55:38 INFO - Running post-run listener: copy_logs_to_upload_dir 05:55:38 INFO - Copying logs to upload dir... 05:55:38 INFO - mkdir: /builds/slave/test/build/upload/logs 05:55:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1293.005643 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-07-21 05:55:38.470946) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 05:55:38.474316) ========= 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.QuBHBMYjED/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.ENvz94MB77/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa3cca4f14fd593f031ff42b26e5c9af48b6fe430d138f1eb607c2fa4564a98ecc2c03fb49617df12892c71f637a60a3f0fb199bb6c584056148aeb6a1044407", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48f6039159bbde59e88e47a06a2951ea64666b4af7cabe2c8d260b4ab0f033d133a37b4a054bdfa956b870f30396bd2e14033b7100e7ea9819836f205cb511f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/245188cefc0bf0dd5b313752a312fca5cdca03b5213676830aeddcfd43818f4e16524f7d4afbfd945f6421c83ff09e086b1d3a79baa20a9a4fc7b2461aec4d64"} build_url:https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa3cca4f14fd593f031ff42b26e5c9af48b6fe430d138f1eb607c2fa4564a98ecc2c03fb49617df12892c71f637a60a3f0fb199bb6c584056148aeb6a1044407", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48f6039159bbde59e88e47a06a2951ea64666b4af7cabe2c8d260b4ab0f033d133a37b4a054bdfa956b870f30396bd2e14033b7100e7ea9819836f205cb511f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/245188cefc0bf0dd5b313752a312fca5cdca03b5213676830aeddcfd43818f4e16524f7d4afbfd945f6421c83ff09e086b1d3a79baa20a9a4fc7b2461aec4d64"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 05:55:38.506894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:55:38.507231) ========= 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.QuBHBMYjED/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.ENvz94MB77/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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.005267 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:55:38.556062) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 05:55:38.556389) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 05:55:38.556773) ========= ========= Total master_lag: 0.17 =========