builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0196 starttime: 1469034627.96 results: success (0) buildid: 20160720075620 builduid: 79d4d09368c34695847800ac0af5effb revision: d224fc999cb6accb208af0a105f14433375e2e77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 10:10:27.962163) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 10:10:27.962577) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 10:10:27.962858) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 10:10:27.997806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:10:27.998096) ========= 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.aEkEef3flf/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.Q4yzg2Obxa/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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-20 10:10:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2016-07-20 10:10:28 (168 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.279315 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:10:28.301949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:10:28.302357) ========= 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.aEkEef3flf/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.Q4yzg2Obxa/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.027423 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:10:28.352533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-20 10:10:28.352876) ========= 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.aEkEef3flf/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.Q4yzg2Obxa/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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-20 10:10:28,425 truncating revision to first 12 chars 2016-07-20 10:10:28,425 Setting DEBUG logging. 2016-07-20 10:10:28,425 attempt 1/10 2016-07-20 10:10:28,425 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-20 10:10:29,515 unpacking tar archive at: mozilla-central-d224fc999cb6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.353119 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-20 10:10:29.728318) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 10:10:29.728721) ========= script_repo_revision: d224fc999cb6accb208af0a105f14433375e2e77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 10:10:29.729170) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 10:10:29.729465) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 10:10:29.748286) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-07-20 10:10:29.748616) ========= /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.aEkEef3flf/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.Q4yzg2Obxa/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 10:10:29 INFO - MultiFileLogger online at 20160720 10:10:29 in /builds/slave/test 10:10:29 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 10:10:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:10:29 INFO - {'append_to_log': False, 10:10:29 INFO - 'base_work_dir': '/builds/slave/test', 10:10:29 INFO - 'blob_upload_branch': 'Firefox', 10:10:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:10:29 INFO - 'branch': 'Firefox', 10:10:29 INFO - 'buildbot_json_path': 'buildprops.json', 10:10:29 INFO - 'config_files': ('talos/mac_config.py',), 10:10:29 INFO - 'default_actions': ('clobber', 10:10:29 INFO - 'read-buildbot-config', 10:10:29 INFO - 'download-and-extract', 10:10:29 INFO - 'populate-webroot', 10:10:29 INFO - 'create-virtualenv', 10:10:29 INFO - 'install', 10:10:29 INFO - 'run-tests'), 10:10:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:10:29 INFO - 'download_minidump_stackwalk': True, 10:10:29 INFO - 'download_symbols': 'ondemand', 10:10:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:10:29 INFO - 'tooltool.py': '/tools/tooltool.py', 10:10:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:10:29 INFO - '/tools/misc-python/virtualenv.py')}, 10:10:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:10:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:10:29 INFO - 'installer_path': 'installer.exe', 10:10:29 INFO - 'log_level': 'info', 10:10:29 INFO - 'log_name': 'talos', 10:10:29 INFO - 'log_to_console': True, 10:10:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:10:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:10:29 INFO - 'opt_config_files': (), 10:10:29 INFO - 'pip_index': False, 10:10:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:10:29 INFO - 'cmd': ('bash', 10:10:29 INFO - '-c', 10:10:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:10:29 INFO - 'enabled': True, 10:10:29 INFO - 'halt_on_failure': False, 10:10:29 INFO - 'name': 'check_screen_resolution'},), 10:10:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:10:29 INFO - 'cmd': ('bash', 10:10:29 INFO - '-c', 10:10:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:10:29 INFO - 'enabled': True, 10:10:29 INFO - 'halt_on_failure': False, 10:10:29 INFO - 'name': 'check_screen_resolution'},), 10:10:29 INFO - 'run_cmd_checks_enabled': True, 10:10:29 INFO - 'sps_profile': False, 10:10:29 INFO - 'sps_profile_interval': 0, 10:10:29 INFO - 'suite': 'dromaeojs', 10:10:29 INFO - 'system_bits': '32', 10:10:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:10:29 INFO - 'title': 't-yosemite-r7-0196', 10:10:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:10:29 INFO - 'use_talos_json': True, 10:10:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:10:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:10:29 INFO - 'work_dir': 'build'} 10:10:29 INFO - [mozharness: 2016-07-20 17:10:29.940337Z] Running clobber step. 10:10:29 INFO - Running pre-action listener: _resource_record_pre_action 10:10:29 INFO - Running main action method: clobber 10:10:29 INFO - rmtree: /builds/slave/test/build 10:10:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:10:32 INFO - Running post-action listener: _resource_record_post_action 10:10:32 INFO - [mozharness: 2016-07-20 17:10:32.090144Z] Finished clobber step (success) 10:10:32 INFO - [mozharness: 2016-07-20 17:10:32.090285Z] Running read-buildbot-config step. 10:10:32 INFO - Running pre-action listener: _resource_record_pre_action 10:10:32 INFO - Running main action method: read_buildbot_config 10:10:32 INFO - Using buildbot properties: 10:10:32 INFO - { 10:10:32 INFO - "project": "", 10:10:32 INFO - "product": "firefox", 10:10:32 INFO - "script_repo_revision": "production", 10:10:32 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 10:10:32 INFO - "repository": "", 10:10:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 10:10:32 INFO - "buildid": "20160720075620", 10:10:32 INFO - "pgo_build": "False", 10:10:32 INFO - "basedir": "/builds/slave/test", 10:10:32 INFO - "buildnumber": 305, 10:10:32 INFO - "slavename": "t-yosemite-r7-0196", 10:10:32 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:10:32 INFO - "platform": "yosemite_r7", 10:10:32 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:10:32 INFO - "branch": "mozilla-central", 10:10:32 INFO - "repo_path": "mozilla-central", 10:10:32 INFO - "revision": "d224fc999cb6accb208af0a105f14433375e2e77", 10:10:32 INFO - "stage_platform": "macosx64", 10:10:32 INFO - "builduid": "79d4d09368c34695847800ac0af5effb", 10:10:32 INFO - "slavebuilddir": "test" 10:10:32 INFO - } 10:10:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 10:10:32 INFO - Running post-action listener: _resource_record_post_action 10:10:32 INFO - [mozharness: 2016-07-20 17:10:32.093522Z] Finished read-buildbot-config step (success) 10:10:32 INFO - [mozharness: 2016-07-20 17:10:32.093629Z] Running download-and-extract step. 10:10:32 INFO - Running pre-action listener: _resource_record_pre_action 10:10:32 INFO - Running main action method: download_and_extract 10:10:32 INFO - mkdir: /builds/slave/test/build/tests 10:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:10:32 INFO - https://queue.taskcluster.net/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:10:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:10:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:10:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/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 10:10:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/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 10:10:32 INFO - Downloaded 1199 bytes. 10:10:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:10:32 INFO - Using the following test package requirements: 10:10:32 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:10:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:10:32 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 10:10:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:10:32 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 10:10:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:10:32 INFO - u'jsshell-mac.zip'], 10:10:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:10:32 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 10:10:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:10:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:10:32 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 10:10:32 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:10:32 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 10:10:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:10:32 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 10:10:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:10:32 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 10:10:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:10:32 INFO - https://queue.taskcluster.net/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:10:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:10:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:10:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/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 10:10:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/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 10:10:33 INFO - Downloaded 18843014 bytes. 10:10: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'] 10:10: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 10:10:37 INFO - Return code: 0 10:10:37 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 10:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:10:37 INFO - https://queue.taskcluster.net/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:10:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:10:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:10:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/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 10:10:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/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 10:10:38 INFO - Downloaded 18843014 bytes. 10:10:38 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'] 10:10:38 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 10:10:41 INFO - Return code: 0 10:10:41 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')]} 10:10:41 INFO - https://queue.taskcluster.net/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:10:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:10:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:10:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/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 10:10:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/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 10:10:43 INFO - Downloaded 14403317 bytes. 10:10:43 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'] 10:10:43 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 10:10:43 INFO - Return code: 0 10:10: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')]} 10:10:43 INFO - https://queue.taskcluster.net/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 10:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q-bGwnCbQSCAc37xP4rDaw/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 10:10:47 INFO - Downloaded 112923148 bytes. 10:10:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:10:47 INFO - mkdir: /builds/slave/test/properties 10:10:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:10:47 INFO - Writing to file /builds/slave/test/properties/build_url 10:10:47 INFO - Contents: 10:10:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:10:48 INFO - Running post-action listener: _resource_record_post_action 10:10:48 INFO - Running post-action listener: set_extra_try_arguments 10:10:48 INFO - [mozharness: 2016-07-20 17:10:48.225839Z] Finished download-and-extract step (success) 10:10:48 INFO - [mozharness: 2016-07-20 17:10:48.225971Z] Running populate-webroot step. 10:10:48 INFO - Running pre-action listener: _resource_record_pre_action 10:10:48 INFO - Running main action method: populate_webroot 10:10:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:10:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:10:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:10:48 INFO - '--tppagecycles', 10:10:48 INFO - '7'], 10:10:48 INFO - 'tests': ['tsvgm']}}, 10:10:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:10:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:10:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:10:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:10:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:10:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:10:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:48 INFO - 'talos_options': ['--disable-e10s'], 10:10:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:10:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:10:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:48 INFO - 'talos_options': ['--disable-e10s'], 10:10:48 INFO - 'tests': ['damp', 'tps']}, 10:10:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:48 INFO - 'tests': ['damp', 'tps']}, 10:10:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:10:48 INFO - 'tests': ['dromaeo_dom']}, 10:10:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:10:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:10:48 INFO - 'tests': ['basic_compositor_video']}, 10:10:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:10:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:10:48 INFO - 'tests': ['a11yr', 10:10:48 INFO - 'ts_paint', 10:10:48 INFO - 'tpaint', 10:10:48 INFO - 'sessionrestore', 10:10:48 INFO - 'sessionrestore_no_auto_restore', 10:10:48 INFO - 'tabpaint']}, 10:10:48 INFO - 'other-e10s': {'tests': ['a11yr', 10:10:48 INFO - 'ts_paint', 10:10:48 INFO - 'tpaint', 10:10:48 INFO - 'sessionrestore', 10:10:48 INFO - 'sessionrestore_no_auto_restore', 10:10:48 INFO - 'tabpaint']}, 10:10:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:10:48 INFO - 'ts_paint', 10:10:48 INFO - 'tpaint', 10:10:48 INFO - 'sessionrestore', 10:10:48 INFO - 'sessionrestore_no_auto_restore', 10:10:48 INFO - 'tabpaint']}, 10:10:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:10:48 INFO - 'ts_paint', 10:10:48 INFO - 'tpaint', 10:10:48 INFO - 'sessionrestore', 10:10:48 INFO - 'sessionrestore_no_auto_restore', 10:10:48 INFO - 'tabpaint']}, 10:10:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:10:48 INFO - 'tests': ['a11yr', 10:10:48 INFO - 'ts_paint', 10:10:48 INFO - 'tpaint', 10:10:48 INFO - 'sessionrestore', 10:10:48 INFO - 'sessionrestore_no_auto_restore', 10:10:48 INFO - 'tabpaint']}, 10:10:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:10:48 INFO - 'tests': ['a11yr', 10:10:48 INFO - 'ts_paint', 10:10:48 INFO - 'tpaint', 10:10:48 INFO - 'sessionrestore', 10:10:48 INFO - 'sessionrestore_no_auto_restore', 10:10:48 INFO - 'tabpaint']}, 10:10:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:10:48 INFO - 'tests': ['tsvgx', 10:10:48 INFO - 'tsvgr_opacity', 10:10:48 INFO - 'tart', 10:10:48 INFO - 'tscrollx', 10:10:48 INFO - 'cart']}, 10:10:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:10:48 INFO - 'tsvgr_opacity', 10:10:48 INFO - 'tart', 10:10:48 INFO - 'tscrollx', 10:10:48 INFO - 'cart']}, 10:10:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:48 INFO - 'talos_options': ['--disable-e10s'], 10:10:48 INFO - 'tests': ['tp5o']}, 10:10:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:48 INFO - 'tests': ['tp5o']}, 10:10:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:48 INFO - 'talos_options': ['--disable-e10s', 10:10:48 INFO - '--xperf_path', 10:10:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:10:48 INFO - 'tests': ['tp5n']}, 10:10:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:48 INFO - 'talos_options': ['--xperf_path', 10:10:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:10:48 INFO - 'tests': ['tp5n']}}, 10:10:48 INFO - 'talos.zip': {'path': '', 10:10:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:10:48 INFO - Running post-action listener: _resource_record_post_action 10:10:48 INFO - [mozharness: 2016-07-20 17:10:48.244844Z] Finished populate-webroot step (success) 10:10:48 INFO - [mozharness: 2016-07-20 17:10:48.244983Z] Running create-virtualenv step. 10:10:48 INFO - Running pre-action listener: _resource_record_pre_action 10:10:48 INFO - Running main action method: create_virtualenv 10:10:48 INFO - Creating virtualenv /builds/slave/test/build/venv 10:10: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 10:10:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:10:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:10:48 INFO - Using real prefix '/tools/python27' 10:10:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:10:49 INFO - Installing distribute.............................................................................................................................................................................................done. 10:10:51 INFO - Installing pip.................done. 10:10:51 INFO - Return code: 0 10:10:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:51 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 0x11032ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe19b5bedc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11028fd30>, '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 0x10fff4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110287b20>, '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.aEkEef3flf/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.Q4yzg2Obxa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 10:10:51 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 10:10:51 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 10:10:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEkEef3flf/Render', 10:10:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:51 INFO - 'HOME': '/Users/cltbld', 10:10:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:51 INFO - 'LOGNAME': 'cltbld', 10:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:51 INFO - 'MOZ_NO_REMOTE': '1', 10:10:51 INFO - 'NO_EM_RESTART': '1', 10:10:51 INFO - 'PAGER': '/bin/cat', 10:10:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:51 INFO - 'PWD': '/builds/slave/test', 10:10:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:51 INFO - 'SHELL': '/bin/bash', 10:10:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4yzg2Obxa/Listeners', 10:10:51 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 10:10:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:51 INFO - 'USER': 'cltbld', 10:10:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:51 INFO - 'XPC_FLAGS': '0x0', 10:10:51 INFO - 'XPC_SERVICE_NAME': '0', 10:10:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10: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 10:10:52 INFO - Cleaning up... 10:10:52 INFO - Return code: 0 10:10:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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 0x11032ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe19b5bedc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11028fd30>, '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 0x10fff4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110287b20>, '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.aEkEef3flf/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.Q4yzg2Obxa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 10:10: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 10:10: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 10:10:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEkEef3flf/Render', 10:10:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:52 INFO - 'HOME': '/Users/cltbld', 10:10:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:52 INFO - 'LOGNAME': 'cltbld', 10:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:52 INFO - 'MOZ_NO_REMOTE': '1', 10:10:52 INFO - 'NO_EM_RESTART': '1', 10:10:52 INFO - 'PAGER': '/bin/cat', 10:10:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:52 INFO - 'PWD': '/builds/slave/test', 10:10:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:52 INFO - 'SHELL': '/bin/bash', 10:10:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4yzg2Obxa/Listeners', 10:10:52 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 10:10:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:52 INFO - 'USER': 'cltbld', 10:10:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:52 INFO - 'XPC_FLAGS': '0x0', 10:10:52 INFO - 'XPC_SERVICE_NAME': '0', 10:10:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:52 INFO - Downloading/unpacking psutil>=3.1.1 10:10:52 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 10:10:52 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 10:10:52 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 10:10:52 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 10:10:52 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 10:10:52 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 10:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:10:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:55 INFO - Installing collected packages: psutil 10:10:55 INFO - Running setup.py install for psutil 10:10:55 INFO - building 'psutil._psutil_osx' extension 10:10:55 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 10:10: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:10: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:10:56 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 10:10:56 INFO - building 'psutil._psutil_posix' extension 10:10:56 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 10:10:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:10:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:10:56 INFO - ^ 10:10:56 INFO - 1 warning generated. 10:10:56 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 10:10:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:56 INFO - Successfully installed psutil 10:10:56 INFO - Cleaning up... 10:10:56 INFO - Return code: 0 10:10:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:56 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 0x11032ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe19b5bedc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11028fd30>, '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 0x10fff4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110287b20>, '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.aEkEef3flf/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.Q4yzg2Obxa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 10:10:56 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 10:10:56 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 10:10:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEkEef3flf/Render', 10:10:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:56 INFO - 'HOME': '/Users/cltbld', 10:10:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:56 INFO - 'LOGNAME': 'cltbld', 10:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:56 INFO - 'MOZ_NO_REMOTE': '1', 10:10:56 INFO - 'NO_EM_RESTART': '1', 10:10:56 INFO - 'PAGER': '/bin/cat', 10:10:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:56 INFO - 'PWD': '/builds/slave/test', 10:10:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:56 INFO - 'SHELL': '/bin/bash', 10:10:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4yzg2Obxa/Listeners', 10:10:56 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 10:10:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:56 INFO - 'USER': 'cltbld', 10:10:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:56 INFO - 'XPC_FLAGS': '0x0', 10:10:56 INFO - 'XPC_SERVICE_NAME': '0', 10:10:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:10:56 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 10:10:56 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 10:10:56 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 10:10:56 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 10:10:56 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 10:10:56 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 10:10:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:10:59 INFO - Installing collected packages: mozsystemmonitor 10:10:59 INFO - Running setup.py install for mozsystemmonitor 10:10:59 INFO - Successfully installed mozsystemmonitor 10:10:59 INFO - Cleaning up... 10:10:59 INFO - Return code: 0 10:10:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:59 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 0x11032ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe19b5bedc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11028fd30>, '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 0x10fff4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110287b20>, '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.aEkEef3flf/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.Q4yzg2Obxa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 10:10:59 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 10:10:59 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 10:10:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEkEef3flf/Render', 10:10:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:59 INFO - 'HOME': '/Users/cltbld', 10:10:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:59 INFO - 'LOGNAME': 'cltbld', 10:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:59 INFO - 'MOZ_NO_REMOTE': '1', 10:10:59 INFO - 'NO_EM_RESTART': '1', 10:10:59 INFO - 'PAGER': '/bin/cat', 10:10:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:59 INFO - 'PWD': '/builds/slave/test', 10:10:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:59 INFO - 'SHELL': '/bin/bash', 10:10:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4yzg2Obxa/Listeners', 10:10:59 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 10:10:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:59 INFO - 'USER': 'cltbld', 10:10:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:59 INFO - 'XPC_FLAGS': '0x0', 10:10:59 INFO - 'XPC_SERVICE_NAME': '0', 10:10:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:59 INFO - Downloading/unpacking jsonschema==2.5.1 10:10:59 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 10:10:59 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 10:10:59 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 10:10:59 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 10:10:59 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 10:10:59 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 10:11:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:11:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:11:02 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 10:11:02 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 10:11:02 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 10:11:02 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 10:11:02 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 10:11:02 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 10:11:02 INFO - Downloading functools32-3.2.3-2.tar.gz 10:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:11:02 INFO - warning: no files found matching '*.txt' 10:11:02 INFO - no previously-included directories found matching 'build' 10:11:02 INFO - no previously-included directories found matching 'dist' 10:11:02 INFO - no previously-included directories found matching '.git*' 10:11:02 INFO - Installing collected packages: jsonschema, functools32 10:11:02 INFO - Running setup.py install for functools32 10:11:02 INFO - warning: no files found matching '*.txt' 10:11:02 INFO - no previously-included directories found matching 'build' 10:11:02 INFO - no previously-included directories found matching 'dist' 10:11:02 INFO - no previously-included directories found matching '.git*' 10:11:02 INFO - Successfully installed jsonschema functools32 10:11:02 INFO - Cleaning up... 10:11:03 INFO - Return code: 0 10:11:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:11:03 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')]} 10:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:03 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')]} 10:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:03 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 0x11032ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe19b5bedc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11028fd30>, '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 0x10fff4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110287b20>, '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.aEkEef3flf/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.Q4yzg2Obxa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 10:11:03 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 10:11:03 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 10:11:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEkEef3flf/Render', 10:11:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:11:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:11:03 INFO - 'HOME': '/Users/cltbld', 10:11:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:11:03 INFO - 'LOGNAME': 'cltbld', 10:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:03 INFO - 'MOZ_NO_REMOTE': '1', 10:11:03 INFO - 'NO_EM_RESTART': '1', 10:11:03 INFO - 'PAGER': '/bin/cat', 10:11:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:03 INFO - 'PWD': '/builds/slave/test', 10:11:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:11:03 INFO - 'SHELL': '/bin/bash', 10:11:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4yzg2Obxa/Listeners', 10:11:03 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 10:11:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:11:03 INFO - 'USER': 'cltbld', 10:11:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:11:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:03 INFO - 'XPC_FLAGS': '0x0', 10:11:03 INFO - 'XPC_SERVICE_NAME': '0', 10:11:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:03 INFO - Downloading/unpacking blobuploader==1.2.4 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:11:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:11:05 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 10:11:05 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 10:11:05 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 10:11:05 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 10:11:05 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 10:11:05 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 10:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:11:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:11:06 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 10:11:06 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 10:11:06 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 10:11:06 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 10:11:06 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 10:11:06 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 10:11:07 INFO - Downloading docopt-0.6.1.tar.gz 10:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:11:07 INFO - Installing collected packages: blobuploader, requests, docopt 10:11:07 INFO - Running setup.py install for blobuploader 10:11:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:11:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:11:07 INFO - Running setup.py install for requests 10:11:07 INFO - Running setup.py install for docopt 10:11:07 INFO - Successfully installed blobuploader requests docopt 10:11:07 INFO - Cleaning up... 10:11:08 INFO - Return code: 0 10:11:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:08 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 0x11032ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe19b5bedc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11028fd30>, '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 0x10fff4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110287b20>, '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.aEkEef3flf/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.Q4yzg2Obxa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 10:11:08 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 10:11:08 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 10:11:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEkEef3flf/Render', 10:11:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:11:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:11:08 INFO - 'HOME': '/Users/cltbld', 10:11:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:11:08 INFO - 'LOGNAME': 'cltbld', 10:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:08 INFO - 'MOZ_NO_REMOTE': '1', 10:11:08 INFO - 'NO_EM_RESTART': '1', 10:11:08 INFO - 'PAGER': '/bin/cat', 10:11:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:08 INFO - 'PWD': '/builds/slave/test', 10:11:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:11:08 INFO - 'SHELL': '/bin/bash', 10:11:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4yzg2Obxa/Listeners', 10:11:08 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 10:11:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:11:08 INFO - 'USER': 'cltbld', 10:11:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:11:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:08 INFO - 'XPC_FLAGS': '0x0', 10:11:08 INFO - 'XPC_SERVICE_NAME': '0', 10:11:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:11:08 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Pe4ruF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:11:08 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-bp82fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:11:08 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-1r5J8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:11:08 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-cJzK2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:11:08 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-8l9B4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:11:08 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-JJahhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:11:08 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-y89d58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:11:09 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-2ZSbmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:11:09 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Pgy0rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:11:09 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-KC1CZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:11:09 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-5pfg_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:11:09 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Rjxc7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:11:09 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-HKMqVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:11:09 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-gCsTzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:09 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-bQA_D1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:11:09 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-PbN7ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:11:09 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-h4GeR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:11:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:11:10 INFO - Running setup.py install for manifestparser 10:11:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:11:10 INFO - Running setup.py install for mozcrash 10:11:10 INFO - Running setup.py install for mozdebug 10:11:10 INFO - Running setup.py install for mozdevice 10:11:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:11:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:11:10 INFO - Running setup.py install for mozfile 10:11:10 INFO - Running setup.py install for mozhttpd 10:11:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:11:10 INFO - Running setup.py install for mozinfo 10:11:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:11:11 INFO - Running setup.py install for mozInstall 10:11:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:11:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:11:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:11:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:11:11 INFO - Running setup.py install for mozleak 10:11:11 INFO - Running setup.py install for mozlog 10:11:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:11:11 INFO - Running setup.py install for moznetwork 10:11:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:11:11 INFO - Running setup.py install for mozprocess 10:11:11 INFO - Running setup.py install for mozprofile 10:11:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:11:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:11:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:11:12 INFO - Running setup.py install for mozrunner 10:11:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:11:12 INFO - Running setup.py install for mozscreenshot 10:11:12 INFO - Running setup.py install for moztest 10:11:12 INFO - Running setup.py install for mozversion 10:11:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:11:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:11:12 INFO - Cleaning up... 10:11:12 INFO - Return code: 0 10:11:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:12 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 0x11032ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe19b5bedc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11028fd30>, '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 0x10fff4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110287b20>, '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.aEkEef3flf/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.Q4yzg2Obxa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 10:11:12 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 10:11:12 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 10:11:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEkEef3flf/Render', 10:11:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:11:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:11:12 INFO - 'HOME': '/Users/cltbld', 10:11:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:11:12 INFO - 'LOGNAME': 'cltbld', 10:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:12 INFO - 'MOZ_NO_REMOTE': '1', 10:11:12 INFO - 'NO_EM_RESTART': '1', 10:11:12 INFO - 'PAGER': '/bin/cat', 10:11:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:12 INFO - 'PWD': '/builds/slave/test', 10:11:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:11:12 INFO - 'SHELL': '/bin/bash', 10:11:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4yzg2Obxa/Listeners', 10:11:12 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 10:11:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:11:12 INFO - 'USER': 'cltbld', 10:11:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:11:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:12 INFO - 'XPC_FLAGS': '0x0', 10:11:12 INFO - 'XPC_SERVICE_NAME': '0', 10:11:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:11:12 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-4qn4uX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:11:13 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)) 10:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:11:13 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-MJZ6al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:11:13 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)) 10:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:11:13 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-DHIHnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:11:13 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)) 10:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:11:13 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-6IXWRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:11:13 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)) 10:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:11:13 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-PB0jnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:11:13 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)) 10:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:11:13 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Ca6O8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:11:13 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)) 10:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:11:13 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-21tAFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:11:13 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)) 10:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:11:13 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-u4i5ZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:11:13 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)) 10:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:11:13 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-T691L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:11:13 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)) 10:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:11:13 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-MhwZrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:11:14 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)) 10:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:11:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-uxDgSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:11:14 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)) 10:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:11:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-IibRzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:11:14 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)) 10:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:11:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-TatD4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:11:14 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)) 10:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:11:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-9QS5p1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:11:14 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)) 10:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-A0NKxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:14 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)) 10:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:11:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-MFNhrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:11:14 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)) 10:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:11:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Zm4FxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:11:14 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)) 10:11:14 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)) 10:11:14 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)) 10:11:14 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)) 10:11:14 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)) 10:11:14 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)) 10:11:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:11:14 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 10:11:14 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 10:11:14 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 10:11:14 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 10:11:14 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 10:11:14 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 10:11:17 INFO - Downloading blessings-1.6.tar.gz 10:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:11:17 INFO - Installing collected packages: blessings 10:11:17 INFO - Running setup.py install for blessings 10:11:17 INFO - Successfully installed blessings 10:11:17 INFO - Cleaning up... 10:11:17 INFO - Return code: 0 10:11:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:11:17 INFO - Reading from file tmpfile_stdout 10:11:17 INFO - Current package versions: 10:11:17 INFO - blessings == 1.6 10:11:17 INFO - blobuploader == 1.2.4 10:11:17 INFO - docopt == 0.6.1 10:11:17 INFO - functools32 == 3.2.3-2 10:11:17 INFO - jsonschema == 2.5.1 10:11:17 INFO - manifestparser == 1.1 10:11:17 INFO - mozInstall == 1.12 10:11:17 INFO - mozcrash == 0.17 10:11:17 INFO - mozdebug == 0.1 10:11:17 INFO - mozdevice == 0.48 10:11:17 INFO - mozfile == 1.2 10:11:17 INFO - mozhttpd == 0.7 10:11:17 INFO - mozinfo == 0.9 10:11:17 INFO - mozleak == 0.1 10:11:17 INFO - mozlog == 3.3 10:11:17 INFO - moznetwork == 0.27 10:11:17 INFO - mozprocess == 0.23 10:11:17 INFO - mozprofile == 0.28 10:11:17 INFO - mozrunner == 6.12 10:11:17 INFO - mozscreenshot == 0.1 10:11:17 INFO - mozsystemmonitor == 0.3 10:11:17 INFO - moztest == 0.7 10:11:17 INFO - mozversion == 1.4 10:11:17 INFO - psutil == 3.1.1 10:11:17 INFO - requests == 1.2.3 10:11:17 INFO - wsgiref == 0.1.2 10:11:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:17 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 0x11032ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe19b5bedc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11028fd30>, '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 0x10fff4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110287b20>, '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.aEkEef3flf/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.Q4yzg2Obxa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 10:11:17 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 10:11:17 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 10:11:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEkEef3flf/Render', 10:11:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:11:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:11:17 INFO - 'HOME': '/Users/cltbld', 10:11:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:11:17 INFO - 'LOGNAME': 'cltbld', 10:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:17 INFO - 'MOZ_NO_REMOTE': '1', 10:11:17 INFO - 'NO_EM_RESTART': '1', 10:11:17 INFO - 'PAGER': '/bin/cat', 10:11:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:17 INFO - 'PWD': '/builds/slave/test', 10:11:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:11:17 INFO - 'SHELL': '/bin/bash', 10:11:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4yzg2Obxa/Listeners', 10:11:17 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 10:11:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:11:17 INFO - 'USER': 'cltbld', 10:11:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:11:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:17 INFO - 'XPC_FLAGS': '0x0', 10:11:17 INFO - 'XPC_SERVICE_NAME': '0', 10:11:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:18 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)) 10:11:18 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)) 10:11:18 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)) 10:11:18 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)) 10:11:18 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)) 10:11:18 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)) 10:11:18 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)) 10:11:18 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)) 10:11:18 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)) 10:11:18 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)) 10:11:18 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)) 10:11:18 INFO - Cleaning up... 10:11:18 INFO - Return code: 0 10:11:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:11:18 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')]} 10:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:18 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')]} 10:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:18 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 0x11032ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe19b5bedc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11028fd30>, '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 0x10fff4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110287b20>, '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.aEkEef3flf/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.Q4yzg2Obxa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 10:11:18 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 10:11:18 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 10:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEkEef3flf/Render', 10:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:11:18 INFO - 'HOME': '/Users/cltbld', 10:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:11:18 INFO - 'LOGNAME': 'cltbld', 10:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:18 INFO - 'MOZ_NO_REMOTE': '1', 10:11:18 INFO - 'NO_EM_RESTART': '1', 10:11:18 INFO - 'PAGER': '/bin/cat', 10:11:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:18 INFO - 'PWD': '/builds/slave/test', 10:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:11:18 INFO - 'SHELL': '/bin/bash', 10:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4yzg2Obxa/Listeners', 10:11:18 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 10:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:11:18 INFO - 'USER': 'cltbld', 10:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:18 INFO - 'XPC_FLAGS': '0x0', 10:11:18 INFO - 'XPC_SERVICE_NAME': '0', 10:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:11:18 INFO - Cleaning up... 10:11:18 INFO - Return code: 0 10:11:18 INFO - Running post-action listener: _resource_record_post_action 10:11:18 INFO - Running post-action listener: _start_resource_monitoring 10:11:18 INFO - Starting resource monitoring. 10:11:18 INFO - [mozharness: 2016-07-20 17:11:18.376982Z] Finished create-virtualenv step (success) 10:11:18 INFO - [mozharness: 2016-07-20 17:11:18.377890Z] Running install step. 10:11:18 INFO - Running pre-action listener: _resource_record_pre_action 10:11:18 INFO - Running main action method: install 10:11:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:11:18 INFO - Reading from file tmpfile_stdout 10:11:18 INFO - Detecting whether we're running mozinstall >=1.0... 10:11:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:11:18 INFO - Reading from file tmpfile_stdout 10:11:18 INFO - Output received: 10:11:18 INFO - Usage: mozinstall [options] installer 10:11:18 INFO - Options: 10:11:18 INFO - -h, --help show this help message and exit 10:11:18 INFO - -d DEST, --destination=DEST 10:11:18 INFO - Directory to install application into. [default: 10:11:18 INFO - "/builds/slave/test"] 10:11:18 INFO - --app=APP Application being installed. [default: firefox] 10:11:18 INFO - mkdir: /builds/slave/test/build/application 10:11:18 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'] 10:11:18 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 10:11:52 INFO - Reading from file tmpfile_stdout 10:11:52 INFO - Output received: 10:11:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:11:52 INFO - Running post-action listener: _resource_record_post_action 10:11:52 INFO - [mozharness: 2016-07-20 17:11:52.916784Z] Finished install step (success) 10:11:52 INFO - [mozharness: 2016-07-20 17:11:52.916913Z] Running run-tests step. 10:11:52 INFO - Running pre-action listener: _resource_record_pre_action 10:11:52 INFO - Running main action method: run_tests 10:11:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:11:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:11:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:11:52 INFO - 2016-07-20 10:11:52.930 screenresolution[1639:7865] starting screenresolution argv=screenresolution get 10:11:52 INFO - 2016-07-20 10:11:52.933 screenresolution[1639:7865] Display 0: 1600x1200x32@60 10:11:52 INFO - 2016-07-20 10:11:52.939 screenresolution[1640:7867] starting screenresolution argv=screenresolution list 10:11:52 INFO - Available Modes on Display 0 10:11:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:11:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:11:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:11:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:11:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:11:53 INFO - Intel Iris: 10:11:53 INFO - Chipset Model: Intel Iris 10:11:53 INFO - Type: GPU 10:11:53 INFO - Bus: Built-In 10:11:53 INFO - VRAM (Dynamic, Max): 1536 MB 10:11:53 INFO - Vendor: Intel (0x8086) 10:11:53 INFO - Device ID: 0x0a2e 10:11:53 INFO - Revision ID: 0x0009 10:11:53 INFO - Displays: 10:11:53 INFO - Display: 10:11:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:11:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:11:53 INFO - Display Serial Number: 1600x1200 60 10:11:53 INFO - Main Display: Yes 10:11:53 INFO - Mirror: Off 10:11:53 INFO - Online: Yes 10:11:53 INFO - Rotation: Supported 10:11:53 INFO - Return code: 0 10:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:11:53 INFO - Python 2.7.3 10:11:53 INFO - Return code: 0 10:11:53 INFO - grabbing minidump binary from tooltool 10:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:11:53 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 0x11028fd30>, '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 0x10fff4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110287b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:11:53 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 10:11:53 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 10:11:53 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 10:11:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:11:53 INFO - Return code: 0 10:11:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:11:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:11:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:11:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:11:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:11:53 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0196', '--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 10:11:53 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0196 --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 10:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEkEef3flf/Render', 10:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:11:53 INFO - 'HOME': '/Users/cltbld', 10:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:11:53 INFO - 'LOGNAME': 'cltbld', 10:11:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:11:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:53 INFO - 'MOZ_NO_REMOTE': '1', 10:11:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:11:53 INFO - 'NO_EM_RESTART': '1', 10:11:53 INFO - 'PAGER': '/bin/cat', 10:11:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:53 INFO - 'PWD': '/builds/slave/test', 10:11:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:11:53 INFO - 'SHELL': '/bin/bash', 10:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4yzg2Obxa/Listeners', 10:11:53 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 10:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:11:53 INFO - 'USER': 'cltbld', 10:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:53 INFO - 'XPC_FLAGS': '0x0', 10:11:53 INFO - 'XPC_SERVICE_NAME': '0', 10:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:11:53 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0196', '--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 10:11:53 INFO - mozversion application_buildid: 20160720075620 10:11:53 INFO - mozversion application_changeset: d224fc999cb6accb208af0a105f14433375e2e77 10:11:53 INFO - mozversion application_display_name: Nightly 10:11:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:11:53 INFO - mozversion application_name: Firefox 10:11:53 INFO - mozversion application_remotingname: firefox 10:11:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:11:53 INFO - mozversion application_vendor: Mozilla 10:11:53 INFO - mozversion application_version: 50.0a1 10:11:53 INFO - mozversion platform_buildid: 20160720075620 10:11:53 INFO - mozversion platform_changeset: d224fc999cb6accb208af0a105f14433375e2e77 10:11:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:11:53 INFO - mozversion platform_version: 50.0a1 10:11:53 INFO - using testdate: 1469034713 10:11:53 INFO - actual date: 1469034713 10:11:53 INFO - starting webserver on 'localhost:49267' 10:11:53 INFO - SUITE-START | Running 2 tests 10:11:53 INFO - TEST-START | dromaeo_css 10:11:53 INFO - operating with platform_type : mac_ 10:11:53 INFO - Initialising browser for dromaeo_css test... 10:11:53 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpXf1xym/profile http://localhost:49267/getInfo.html) 10:11:55 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 10:11:55 INFO - PROCESS | 1650 | colorDepth:24 10:11:55 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 10:11:55 INFO - PROCESS | 1650 | __metrics 10:11:55 INFO - PROCESS | 1650 | 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" 10:11:55 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:11:56 INFO - TEST-INFO | 1650: exit 0 10:11:56 INFO - Browser initialized. 10:11:56 INFO - Running cycle 1/1 for dromaeo_css test... 10:11:56 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpXf1xym/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:08 INFO - PROCESS | 1652 | RSS: Main: 245149696 10:12:08 INFO - PROCESS | 1652 | 10:13:00 INFO - PROCESS | 1652 | 1469034780290 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] 10:15:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 10:15:12 INFO - PROCESS | 1652 | RSS: Main: 357502976 10:15:12 INFO - PROCESS | 1652 | 10:18:15 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 10:18:16 INFO - PROCESS | 1652 | RSS: Main: 381857792 10:18:16 INFO - PROCESS | 1652 | 10:21:18 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 10:21:19 INFO - PROCESS | 1652 | RSS: Main: 376135680 10:21:19 INFO - PROCESS | 1652 | 10:24:21 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 10:24:21 INFO - PROCESS | 1652 | RSS: Main: 374976512 10:24:21 INFO - PROCESS | 1652 | 10:27:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 10:27:25 INFO - PROCESS | 1652 | RSS: Main: 337264640 10:27:25 INFO - PROCESS | 1652 | 10:30:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 10:30:29 INFO - PROCESS | 1652 | RSS: Main: 394014720 10:30:29 INFO - PROCESS | 1652 | 10:30:29 INFO - PROCESS | 1652 | __start_tp_report 10:30:29 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 10:30:29 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 10:30:29 INFO - PROCESS | 1652 | |i|pagename|runs| 10:30:29 INFO - PROCESS | 1652 | |0;dojo.html;2890.9999999999995;3366.848491817868;3383.9002324244625;3403.115190050586;3440.3807314683345;5614.691191984444;5648.6893220872935;5691.971540142294;5724.742386592603;5726.942730572693;5700.287464066992;5750.281214848144;5751.281089863767;5760.193572899798;5771.567132465071;5174.948250517485;5222.869428264305;5249.42256351801;5255.789768409278;5310.0441920454305;5228.424873263938;5264.6051546134;5265.368155821307;5275.314209152804;5279.234510995903;5191.377034755816;5196.324477817897;5225.16397376418;5236.659617124875;5252.606054545905;5285.709285989288;5335.839924802262;5340.91988620171;5346.35791143945;5362.088444964326;5089.643724939256;5130.97434512825;5135.050015747099;5252.185911183773;5288.814891478818;5665.830025099253;5676.914846277309;5700.743466543974;5701.059325211335;5729;6254;6259.906101408483;6267.8746425071695;6279.403456671609;6295.748170073191;6118.1434599156155;6238.376162383771;6301.1493448384335;6308.747650093991;6323.588966717149;5886.705664716747;5908.084246941731;5917.615355001911;5919.82240532789;5930.377310382434;5362.8659283517445;6317.210348706411;6321.336259692758;6330.905036424458;6337.714802833883;6003.669798161143;6080.665563393967;6104.822969073539;6163.599366041193;6207.6275423474735;5252.632315737862;6317.178766760384;6322;6329.208848893888;6333.366663333722;6225.595336303126;6253.843653908598;6258.9374106259265;6272.498200143978;6289.842753931189;6102.640737559575;6172.043333283348;6203.503719702413;6298.464630506367;6301.558890877594;4970.478099799469;4988.72562009093;5010.724410157476;5028.472010438924;5029.497050294941;4473.418455600751;4511.142882852248;4576.748278844696;4611.216093264086;4626.976865115653;5800.187973683687;5823.039198532195;5828.475437210672;5855.590108692436;5907.734151963172;6145.002874065857;6302.023186406114;6328.715522538731;6353.237611486558;6392.456641185551;4893;5713.285839270091;5751.827445176651;5839.124131380242;5842.737076831553;5463.016657001698;5478.342598888159;5489.34127904646;5489.890202195934;5523.143912693539;6265.530085243625;6326.905096423649;6340.302566717565;6341.809745707544;6348.301686814447;6154.415330543591;6225.595336303307;6277.1525844010475;6300.905486417616;6313.116163736989;5347.385050719217;6311.96844015777;6322.778702745381;6322.841928951813;6331.9366806331345;6175.570346476937;6233.407826256498;6237.407446292595;6254.093156492192;6263.467605253422;5738.340090889435;6123.173371594778;6242.157308763259;6272.2159730033745;6329.461995730415;5139.511746384088;6138.5396095292135;6182.350853160354;6194.38056194377;6211.720472578654;6144.262688477412;6155.415235552616;6169.753209871735;6171.352008039271;6176.969115154396;5885.646861188342;6016.699165041643;6050.848728781815;6053.818385448443;6092.994655881907;6156.476699480594;6162.414570615784;6166.537509686702;6181.84545386369;6182.289036760651;6019;6047.667378294236;6072.042188477599;6076.635401875901;6082.239720034996 10:30:29 INFO - PROCESS | 1652 | |1;ext.html;507.49757739837526;518.0054295752155;534.8689571055093;544.9019176548222;558.4136656510663;31051.68948310516;31179.064628061165;43533.564664353384;44361.556384436146;44510.77744611273;45742;46070;46080;46159.538404615945;46326.768366158205;9738.513074346272;9908.653197138101;9926.305158638897;9943.10512053915;9958.651447199349;8759.299256059532;8945.686900958468;9874.308798384116;10735.624253151142;11352.829707554394;12202.694932626711;12280.324582147978;12310.507579696801;12317.568885089024;12325.013998880067;12029.639110826689;12169.391530423443;12169.756604867942;12184.02527797774;12195.939020304842;8721.60752766127;11665.24175928562;11896.345700986441;11918.821217681654;12075.758484830341;43279.783601082105;43697.12605747867;43729.781351093356;43775.12449751019;43826.78086609578;3558.395072837624;3622.4023036198996;3727.1986522897437;3728.179800443925;3850.466918733322;33422.164445888804;33770;33963.830180848934;34072.659273407444;34110;3309.9834500827583;3314.320564284316;3347.2134048498583;3376.4260075787174;3454.602720687103;369843;370236;370563;370795.14602427086;372322;65166.69666606641;65591.67204163948;65632.34367656359;65797.01304480436;65854.34145658482;68372.658136709;68745.65627171932;68789.62420751558;69096.96354554685;69638;17166.313347465963;17413.65172696539;17424.128793560525;17451.04019278952;17453.7381939271;12131.939340303243;12359.567415140427;12365.443555040045;12533;13106.541271055466;18118.547036323933;18751.249950001846;18757.437276881716;18806.153723082494;18851.151698173617;6911.3779759821855;7296.7446139384865;7394.334509894028;7395.670363835375;7412.147603025721;964.7491652170346;1018.7554986803113;1031.8142734307896;1063.6277302944063;1081.6700906223678;32017.519737203962;32049.489724591138;32155.35689286248;32439.51340729891;32739;1078.9730256743644;1118.546988469671;1134.002078171204;1144.4792619358172;1184.5676328140166;13738.587842364745;16551.172441377883;16573.50279491617;16607.00357978525;17000.744988825176;672429;674004;676023;679082;680186;63145.684271579266;63341;63344.683276583324;63416.04875926865;63467;1263.7977923532374;1303.7262174943178;1385.681293302526;1401.614555997109;1437.7771445425976;24171.51656966886;28353.43293134167;29242.415151696423;32340.029799106065;34206.315873682885;59963.40036599578;60862.695686521285;60954.08568871559;60999.390006101145;61088.694556526934;627561;630412;630509;631785;632800;24483.51032979295;27569.03508377197;27902.72097279001;28010.579841302806;28879.56680649834;49081.06603299893;49132.01735965332;49347.50652493429;49598.75200624118;51091.744541277054;33757.98726038223;36372.27255454929;40578.79710601428;41363.965900852716;42534.787326063175;39606.80196598999;40986.79506602448;41490.37764433475;42729.5727042738;42812.78593607012;40149;40692;41158.588414115475;41425.37861932013;41570.79214603908;35507;35692.82153589215;36738.26523469569;36839.44740828836;37031.814840925625;26364;26722.7974741141;26735;26799.598006030315;27172.228740600014 10:30:29 INFO - PROCESS | 1652 | |2;jquery.html;364.58801554243735;384.9326367885621;387.36085458992665;399.9240144372569;422.7611399559249;15684.52946411608;17397.82602173978;20756.584868302623;21261.787382126175;21294;17916.55208619785;17931.462056138305;21565;21921.342359729195;21959.451013724665;5813.447722466359;5931.673757943322;6019.909701354483;6126.417990290915;6178.598391104586;6057.273127224739;6152.876942461148;6154.323024467305;6160.260768707762;6167.660778657172;5371.248025276464;5768.538516918637;5970.626755846158;6046.365131661156;6112.602680825732;6123.755049798003;6126.356732543063;6127.632342059491;6135.233095863017;6142.293636231823;5163.586913046947;5399.838004859821;5472.398036216013;5512.255845460852;5525.4474552544825;12629.115961882671;12873.098883078188;16382.75425868613;25706.10028649007;26013.479730405284;2130.88280144592;2219.2454565447824;2299.1033496936207;2366.290112966103;2414.6740190074293;9198.770030749218;9595.856062159004;9913.553890074963;10092;10109.696709098738;1823.717323814811;1834.0829585207396;1838.5771272607242;1844.6402951424477;1895.649304878602;120595;125173;126927;127318;130360.99999999905;9316.906830931739;9504.95247523758;10031;10064.547095380725;10181.54183061764;12458;12525;12554.058445616616;12565.93717031409;12619.684507887192;6721.8655626887185;8119.959400202961;8241.299489543337;8295;8320.500769953822;8599;8605.440646357967;8625.741227763177;8759.255463285692;8788.912110878937;3902.551206611276;3911.061345277113;3915.353966595537;3982.5021872265966;3987.5414327352146;1474.277603974045;1890.981090189108;1946.5425624978118;1971.6549603819274;1994.1026538057931;865.4201684871151;947.4552132523688;970.9417434953784;979.4759803505233;1005.8239808033711;20782.27262045821;22038.371941892383;22126;22196;22249.77750222477;943.919766819828;961.240619910277;980.8332583460686;984.3798407003542;997.7306127345576;11120;11342.60300889465;11695.473703683354;11756.706082347839;11777.17559770825;584424;590978;594150;608024;609129;105990;113507;122859;133848.33075834558;142582;909.1317791509225;945.6548359848744;948.5589201021559;972.9221662267001;978.2418625565101;19275.903620481808;19628.705569416757;19691.31080412236;19720.11259493355;19798.010099495255;52343;54671.45328546664;54834;55238;55591;83248.58375708082;86338;87613.42899282707;88899.55550222466;89239;7787.766367008999;7863.960680196562;7879.172686867796;7936.6428510716005;8279.089300176855;12032.278063315878;12909.031822613153;13176.143550669176;13373.264470454218;13457.394417251444;11265.549378024787;11345.205835591429;11422.086233101165;11471.369074700971;11633.418329083343;11124.276922000045;11405.600803971822;11527.481263343338;11657.843298989375;11731.23746956445;11410.486528106088;11627.883721163018;11893.345865977108;12012.579559715368;12026.579069732517;7941.920580794118;8053.154418785943;8183.8772418414965;8190.918090819016;8227.382946278933;9352.906470935204;11322.94338528302;11703.707407314545;11751.353675547927;11755.353455560027 10:30:29 INFO - PROCESS | 1652 | |3;mootools.html;1559.6256898344393;1595.8723302135827;1787.5709829640882;1887.2073729033805;1916.6933290673487;7899.4075444341615;8129.674813007473;8496.447730897487;8925.464472131669;8930.732078037652;7499.962500187505;7621.5427074375575;8449.788755281106;8594.09761974993;8720.476771393705;2300.4478925057992;2333.9649905251435;2335;2336.754640762721;2337.0301324950124;2050;2123.830093592509;2286;2304.665823455598;2333.8249631277636;2258.6612008198736;2319.2926157521947;2322.407786014564;2333.5799556079983;2334.8482348647285;2295.644175152854;2313.375388645065;2324.407276144581;2325.616273314901;2328.3247858121294;2296.494771150361;2318.594246006959;2318.802901753353;2319.3273950554317;2339.6022676145094;8820.162084601952;8881.467111973303;8884.244839188677;8892.066333035003;8908.109189081104;5082.517160869711;5193.169092945111;5251.133562962106;5254.106801843695;5257.842264732026;3330.150811543041;3484.9651503484893;3536.398812201932;3541.3802584547857;3546.2730140321173;1023.534291897185;1057.1437135919853;1063.8936106389299;1073.742301847551;1079.568172730906;11512.827307590393;11585.246958947726;11598.478068486938;11612.593559225386;11625.6512304631;4290.764007979528;4500.774961251925;4566.748828814447;4597.816087356535;4617.607503362252;9867.11195992364;9876.60493580263;9876.703698889045;9883.308168428284;9896.802063958681;5226.869328266747;5229.189475631283;5231;5231.215317702375;5232.895342093137;4135.875923722293;4221.155768846243;4801.18379875422;4801.591864691471;4804.06320767454;3840.7503512271614;3866.709996750255;3924.548676902136;3964.5638979712207;3969.6824254059607;1171.543098191706;1212.3332167307944;1212.9393530323448;1277.5081593586535;1288.6520639427301;716.7885473785246;845.9830803383898;877.2455688108222;905.6196397513061;944.2729098594044;5787.710614469344;5921.555883308769;5944.078667806497;5976.073708575178;5987.700614969234;958;966.7196513011148;970.4129001953717;1003.6537394598852;1031.747221930632;3570.1967057411875;3635.818209089535;3942.7634341939574;3992.3811809169624;4091.0999580092334;10288.845667314996;10585;10598.31110977784;10599.311044782064;10629.4153821539;10464.319819211727;10507.159427245802;10545.261831671864;10556.630517931835;10590.099841513558;6971.407430368476;6977.197622273402;7215.891761623579;7680.9231907680205;8178.5092894426525;5756.280464941882;5852.561057920588;6046.5767396281835;6105.9694701526205;6190.597611155261;10004.799904001733;10022.498875056071;10025.5488503019;10027.498625068863;10029.949850250994;8174.019117705913;9965.551550180115;9996.150327222267;10229.335093218917;10279.794404111726;6137.907931381123;7435.7025718970635;7437.925620743939;7456.66445009965;7458.962705186439;8100.635471403683;8102.189781021851;8139.308158806568;8188.263056324721;8211.343092552463;5899.616524925866;7480.887786683095;7553.055868016498;7704.8459030820195;7752.418568607264;7709.498882572615;7726.690932362642;7745.845083098419;7768.184340644151;7824.726134585262;6850.965745171242;6995.685194166376;7049.189343225595;7085.504014719127;7163.534370265916;5120.385553733576;5145.794168233228;5221.556167725786;5286.762095705625;5377.542908852792;5077.365329333833;5166.121759300852;5251.317328747238;5330.173823057432;5457.808976685797 10:30:29 INFO - PROCESS | 1652 | |4;prototype.html;301.15676106900685;305.4212267752609;314.07974634321437;315.81682624078024;317.5474948198816;5136.409312929014;5345.893082138355;5504.073574249011;5577;5620.466055724704;3952.446657467957;4702.929456058162;4803.759812009403;5412.591396828413;5481.945180548193;3449.72402207824;3673.797941113238;3872.244912242114;4061.2689715851134;4237.597428244312;3587.497750314958;4099.815508302118;4233.618974292313;4252.893677658052;4256.2338779019765;3594.388953877834;4142.316517774563;4172.728772629769;4200.915981680365;4204.159168166364;3129.6087989001376;3411.7782344147677;3975.8012099394914;3981.029390451716;4204.642605378546;3621.692156166729;3640.490331353586;3655.4882316475714;3656.2687462507606;3665.4501824726503;4452.799624016927;5306.840794776124;5407.918881216785;5431.289143919653;5460.798624302687;4196.790160491993;4871.902561948777;4881.219004959225;4892;4894.461609222983;5106.961357991989;5567.331920169565;5787.958167529843;5838.956365272164;5903.586748927577;3450.27544215715;3612.747107702462;3857.8842634721004;3943.7239393242485;3945.4279129526058;6051.576389652726;6069.848253793646;6083.8174854754425;6087.421694939018;6103.938960610381;3992.201559688074;4020.798960052044;4038.697097717683;4041.8989525261513;4042.3128068227884;3963.9981809186174;3970.2059588082498;3982.9893164609757;4024.8188831502653;4062.735922165109;4213.389058586487;4529.705569137996;4753.239481682914;4769.809207631725;4792.7363994980615;5039.7228152451235;5373.892522149535;5979.820605381846;5981.461668449861;5994.280686317583;1117.9049780768562;1244.2658831289582;1277.4570807406815;1368.9452421903013;1379.5654368873772;816.07783204978;828.5732847583499;843.3843294395126;851.714675583674;853.0318088969065;4494.52807455219;4503.909921801611;4508.504064552896;4571.131485017836;4614.054118905617;4503.932441013388;5007.874803129951;5037.665018770029;5051.393832740095;5160.48395160481;3943.211357728466;4006.5159601046953;4468.664850136188;4552.517324246954;4578.816847326069;2241.5429970519294;2496.7752902238885;2593.948121037569;2663.280914153168;2671.639328690641;4197.984967215692;4554.817807287672;4943.975280123576;5203.947960520422;5213.765380557884;4569.451665800058;4620.145273124483;4824.49342819006;5143.376877792353;5230.045024561186;3989.623579864942;4413.815161495017;5124.078470573535;5189;5209.749660081553;4649.744264065509;4797.249004113403;4847.127517046965;5022.899542009212;5042.243663450512;4651.906961860812;4847.709137451764;4898.583620392306;4939.838503357926;4978.9130738942085;4535.165521549032;4924.8276310328965;4981.452040275639;5171.741412929263;5207.71357575337;3471.2883858808377;3490.5985811631986;3498.9825050874583;3504.9824750876082;3511.5083888256177;4778.665493415428;4958.157113290677;5055.570276526537;5068.873278168076;5075.720835354091;5160.200168973815;5707.600467967202;5821.650700957956;5915.112733090071;5916.171735956884;5157;5827.621204621855;5845.649261044351;5868.823935281948;5877.911831322619;5363.704996225245;5710.914336284876;5718.542516598745;5736.307789202112;5772.864040305114;5464.863378415572;5717.714114294352;5864.595515838486;5894.646321220741;5903.203067585821;5140.794368225379;5183;5673.74468148926;5775.27809023872;5788.913166302593 10:30:29 INFO - PROCESS | 1652 | |5;yui.html;741.6403044523408;741.7107328142025;766.8351304469542;802.0776107476399;829.3489610655629;14719;16135.193240337965;16157.757633635505;16174.19129043549;16189.919050404746;14180.645483862909;14307.713845723105;14315.642108947282;14321.856781432209;14332.928335358334;711.1359697966969;734.6290123487631;886.3042511628373;890.4479222881806;912.9497877616728;902.512643172686;915.0849150849151;915.244922938575;920.1580553793272;920.5397301349325;968.1045033344163;968.6609686609665;971.159946646153;971.68905950096;973.0221127766584;760.8896709977022;942.8350038743192;962.3023308101606;964.4936408385583;965.8985806490358;714.5962531169924;715.181117620327;715.4455297144702;718.8310746974457;721.2787212787213;15414.845851541453;15421;15424.305906234134;15429.459968901034;15451.38194472231;11907.404629768564;14515.419383224764;14530.491432799907;14623.926880365636;14632;11396.829047564293;11743.236689615147;12816.55142070023;13128.60614181576;13228;4630.837920672794;4675.485696573374;4793.976030119827;4851.393575803025;4862.902741945177;82303.7654435184;109863;111162;111472.4426377871;113807;11410;11501.942490287494;11503.137264705181;11512.712182195512;12039;23356.416089597555;23388;23422.414439639146;23435.296941091452;23457.41356466102;7992.160823113606;8013.439059265912;8086.7169649062;8226.62980165882;8232.135625759209;3799.297130030953;4312.439382880206;4327.870163895088;4330.133973205371;4364.6944713869725;3249.415105281072;3315.1380641033024;3344.1138098403944;3352.664733526628;3366.629670736217;548.8885007859117;561.6405500479697;565.104309669179;579.7847079309793;607.6475644126396;465.52283908993553;474.6985664103319;600.9188759517409;603.9456448919618;607.6293460988793;8306.70926517569;9406;9502.144806967406;9676.225901927828;9699.854502182472;626.37988391493;644.932282110381;677.1231255524108;679.5650783498564;682.2393031769541;4365.475145615577;4591.655625828076;4705.4588722296685;4738.64460165489;4857.95142048575;142564.28717856345;143032.56967430402;144687.2765636165;154766.45233547746;155196;98279;126759;132120;133214.99999999805;133305;113437.43281283541;113754;115420.42289788666;115478.84521154681;117909.41045294718;8442.071372148936;8908.153725396078;9006.909930900869;9031.683891063782;9116.635334586543;58311.4168858306;60787.478454932694;61990;62120;66019;89262;93717;97237.51381243048;99017.50491247498;100709;11990.880091199326;12321.630351089481;12406.131570789958;12636.052296078014;12784.74430511366;11454.008304056066;13376.028090756332;13447;13649.317534123453;13872;9865.408075515492;12084;12221.083418743452;12238.053659311045;12649.810252846399;10149.64476243328;12137.271763694207;12587.874121259036;12645.367731613198;12855.871441285468;12068.517259309529;12365.443555039865;12436.564720234748;12638.304893230961;12640.178388404724;10119.696409107739;10314.43270620123;10352.016558426938;10639.50253802085;10694.786104277715;9555.283353748358;9924.950375248078;10634.89365106339;10665.253432259979;10828.891711083104 10:30:29 INFO - PROCESS | 1652 | __end_tp_report 10:30:29 INFO - PROCESS | 1652 | __start_cc_report 10:30:29 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1208 10:30:29 INFO - PROCESS | 1652 | __end_cc_report 10:30:29 INFO - PROCESS | 1652 | __startTimestamp1469035829615__endTimestamp 10:30:29 INFO - PROCESS | 1652 | 10:30:29 INFO - PROCESS | 1652 | ------- Summary: start ------- 10:30:29 INFO - PROCESS | 1652 | Number of tests: 6 10:30:29 INFO - PROCESS | 1652 | 10:30:29 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5763.93 Median:6016.70 stddev:646.72 (10.7%) stddev-sans-first:608.17 10:30:29 INFO - PROCESS | 1652 | Values: 2891.0 3366.8 3383.9 3403.1 3440.4 5614.7 5648.7 5692.0 5724.7 5726.9 5700.3 5750.3 5751.3 5760.2 5771.6 5174.9 5222.9 5249.4 5255.8 5310.0 5228.4 5264.6 5265.4 5275.3 5279.2 5191.4 5196.3 5225.2 5236.7 5252.6 5285.7 5335.8 5340.9 5346.4 5362.1 5089.6 5131.0 5135.1 5252.2 5288.8 5665.8 5676.9 5700.7 5701.1 5729.0 6254.0 6259.9 6267.9 6279.4 6295.7 6118.1 6238.4 6301.1 6308.7 6323.6 5886.7 5908.1 5917.6 5919.8 5930.4 5362.9 6317.2 6321.3 6330.9 6337.7 6003.7 6080.7 6104.8 6163.6 6207.6 5252.6 6317.2 6322.0 6329.2 6333.4 6225.6 6253.8 6258.9 6272.5 6289.8 6102.6 6172.0 6203.5 6298.5 6301.6 4970.5 4988.7 5010.7 5028.5 5029.5 4473.4 4511.1 4576.7 4611.2 4627.0 5800.2 5823.0 5828.5 5855.6 5907.7 6145.0 6302.0 6328.7 6353.2 6392.5 4893.0 5713.3 5751.8 5839.1 5842.7 5463.0 5478.3 5489.3 5489.9 5523.1 6265.5 6326.9 6340.3 6341.8 6348.3 6154.4 6225.6 6277.2 6300.9 6313.1 5347.4 6312.0 6322.8 6322.8 6331.9 6175.6 6233.4 6237.4 6254.1 6263.5 5738.3 6123.2 6242.2 6272.2 6329.5 5139.5 6138.5 6182.4 6194.4 6211.7 6144.3 6155.4 6169.8 6171.4 6177.0 5885.6 6016.7 6050.8 6053.8 6093.0 6156.5 6162.4 6166.5 6181.8 6182.3 6019.0 6047.7 6072.0 6076.6 6082.2 10:30:29 INFO - PROCESS | 1652 | 10:30:29 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:71138.15 Median:370039.50 stddev:153887.52 (41.6%) stddev-sans-first:154227.84 10:30:29 INFO - PROCESS | 1652 | Values: 507.5 518.0 534.9 544.9 558.4 31051.7 31179.1 43533.6 44361.6 44510.8 45742.0 46070.0 46080.0 46159.5 46326.8 9738.5 9908.7 9926.3 9943.1 9958.7 8759.3 8945.7 9874.3 10735.6 11352.8 12202.7 12280.3 12310.5 12317.6 12325.0 12029.6 12169.4 12169.8 12184.0 12195.9 8721.6 11665.2 11896.3 11918.8 12075.8 43279.8 43697.1 43729.8 43775.1 43826.8 3558.4 3622.4 3727.2 3728.2 3850.5 33422.2 33770.0 33963.8 34072.7 34110.0 3310.0 3314.3 3347.2 3376.4 3454.6 369843.0 370236.0 370563.0 370795.1 372322.0 65166.7 65591.7 65632.3 65797.0 65854.3 68372.7 68745.7 68789.6 69097.0 69638.0 17166.3 17413.7 17424.1 17451.0 17453.7 12131.9 12359.6 12365.4 12533.0 13106.5 18118.5 18751.2 18757.4 18806.2 18851.2 6911.4 7296.7 7394.3 7395.7 7412.1 964.7 1018.8 1031.8 1063.6 1081.7 32017.5 32049.5 32155.4 32439.5 32739.0 1079.0 1118.5 1134.0 1144.5 1184.6 13738.6 16551.2 16573.5 16607.0 17000.7 672429.0 674004.0 676023.0 679082.0 680186.0 63145.7 63341.0 63344.7 63416.0 63467.0 1263.8 1303.7 1385.7 1401.6 1437.8 24171.5 28353.4 29242.4 32340.0 34206.3 59963.4 60862.7 60954.1 60999.4 61088.7 627561.0 630412.0 630509.0 631785.0 632800.0 24483.5 27569.0 27902.7 28010.6 28879.6 49081.1 49132.0 49347.5 49598.8 51091.7 33758.0 36372.3 40578.8 41364.0 42534.8 39606.8 40986.8 41490.4 42729.6 42812.8 40149.0 40692.0 41158.6 41425.4 41570.8 35507.0 35692.8 36738.3 36839.4 37031.8 26364.0 26722.8 26735.0 26799.6 27172.2 10:30:29 INFO - PROCESS | 1652 | 10:30:29 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:35181.50 Median:374.76 stddev:100000.52 (26683.9%) stddev-sans-first:100246.88 10:30:29 INFO - PROCESS | 1652 | Values: 364.6 384.9 387.4 399.9 422.8 15684.5 17397.8 20756.6 21261.8 21294.0 17916.6 17931.5 21565.0 21921.3 21959.5 5813.4 5931.7 6019.9 6126.4 6178.6 6057.3 6152.9 6154.3 6160.3 6167.7 5371.2 5768.5 5970.6 6046.4 6112.6 6123.8 6126.4 6127.6 6135.2 6142.3 5163.6 5399.8 5472.4 5512.3 5525.4 12629.1 12873.1 16382.8 25706.1 26013.5 2130.9 2219.2 2299.1 2366.3 2414.7 9198.8 9595.9 9913.6 10092.0 10109.7 1823.7 1834.1 1838.6 1844.6 1895.6 120595.0 125173.0 126927.0 127318.0 130361.0 9316.9 9505.0 10031.0 10064.5 10181.5 12458.0 12525.0 12554.1 12565.9 12619.7 6721.9 8120.0 8241.3 8295.0 8320.5 8599.0 8605.4 8625.7 8759.3 8788.9 3902.6 3911.1 3915.4 3982.5 3987.5 1474.3 1891.0 1946.5 1971.7 1994.1 865.4 947.5 970.9 979.5 1005.8 20782.3 22038.4 22126.0 22196.0 22249.8 943.9 961.2 980.8 984.4 997.7 11120.0 11342.6 11695.5 11756.7 11777.2 584424.0 590978.0 594150.0 608024.0 609129.0 105990.0 113507.0 122859.0 133848.3 142582.0 909.1 945.7 948.6 972.9 978.2 19275.9 19628.7 19691.3 19720.1 19798.0 52343.0 54671.5 54834.0 55238.0 55591.0 83248.6 86338.0 87613.4 88899.6 89239.0 7787.8 7864.0 7879.2 7936.6 8279.1 12032.3 12909.0 13176.1 13373.3 13457.4 11265.5 11345.2 11422.1 11471.4 11633.4 11124.3 11405.6 11527.5 11657.8 11731.2 11410.5 11627.9 11893.3 12012.6 12026.6 7941.9 8053.2 8183.9 8190.9 8227.4 9352.9 11322.9 11703.7 11751.4 11755.4 10:30:29 INFO - PROCESS | 1652 | 10:30:29 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5643.33 Median:5101.45 stddev:3150.81 (61.8%) stddev-sans-first:3144.71 10:30:29 INFO - PROCESS | 1652 | Values: 1559.6 1595.9 1787.6 1887.2 1916.7 7899.4 8129.7 8496.4 8925.5 8930.7 7500.0 7621.5 8449.8 8594.1 8720.5 2300.4 2334.0 2335.0 2336.8 2337.0 2050.0 2123.8 2286.0 2304.7 2333.8 2258.7 2319.3 2322.4 2333.6 2334.8 2295.6 2313.4 2324.4 2325.6 2328.3 2296.5 2318.6 2318.8 2319.3 2339.6 8820.2 8881.5 8884.2 8892.1 8908.1 5082.5 5193.2 5251.1 5254.1 5257.8 3330.2 3485.0 3536.4 3541.4 3546.3 1023.5 1057.1 1063.9 1073.7 1079.6 11512.8 11585.2 11598.5 11612.6 11625.7 4290.8 4500.8 4566.7 4597.8 4617.6 9867.1 9876.6 9876.7 9883.3 9896.8 5226.9 5229.2 5231.0 5231.2 5232.9 4135.9 4221.2 4801.2 4801.6 4804.1 3840.8 3866.7 3924.5 3964.6 3969.7 1171.5 1212.3 1212.9 1277.5 1288.7 716.8 846.0 877.2 905.6 944.3 5787.7 5921.6 5944.1 5976.1 5987.7 958.0 966.7 970.4 1003.7 1031.7 3570.2 3635.8 3942.8 3992.4 4091.1 10288.8 10585.0 10598.3 10599.3 10629.4 10464.3 10507.2 10545.3 10556.6 10590.1 6971.4 6977.2 7215.9 7680.9 8178.5 5756.3 5852.6 6046.6 6106.0 6190.6 10004.8 10022.5 10025.5 10027.5 10029.9 8174.0 9965.6 9996.2 10229.3 10279.8 6137.9 7435.7 7437.9 7456.7 7459.0 8100.6 8102.2 8139.3 8188.3 8211.3 5899.6 7480.9 7553.1 7704.8 7752.4 7709.5 7726.7 7745.8 7768.2 7824.7 6851.0 6995.7 7049.2 7085.5 7163.5 5120.4 5145.8 5221.6 5286.8 5377.5 5077.4 5166.1 5251.3 5330.2 5457.8 10:30:29 INFO - PROCESS | 1652 | 10:30:29 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4395.82 Median:4800.50 stddev:1359.63 (28.3%) stddev-sans-first:1328.25 10:30:29 INFO - PROCESS | 1652 | Values: 301.2 305.4 314.1 315.8 317.5 5136.4 5345.9 5504.1 5577.0 5620.5 3952.4 4702.9 4803.8 5412.6 5481.9 3449.7 3673.8 3872.2 4061.3 4237.6 3587.5 4099.8 4233.6 4252.9 4256.2 3594.4 4142.3 4172.7 4200.9 4204.2 3129.6 3411.8 3975.8 3981.0 4204.6 3621.7 3640.5 3655.5 3656.3 3665.5 4452.8 5306.8 5407.9 5431.3 5460.8 4196.8 4871.9 4881.2 4892.0 4894.5 5107.0 5567.3 5788.0 5839.0 5903.6 3450.3 3612.7 3857.9 3943.7 3945.4 6051.6 6069.8 6083.8 6087.4 6103.9 3992.2 4020.8 4038.7 4041.9 4042.3 3964.0 3970.2 3983.0 4024.8 4062.7 4213.4 4529.7 4753.2 4769.8 4792.7 5039.7 5373.9 5979.8 5981.5 5994.3 1117.9 1244.3 1277.5 1368.9 1379.6 816.1 828.6 843.4 851.7 853.0 4494.5 4503.9 4508.5 4571.1 4614.1 4503.9 5007.9 5037.7 5051.4 5160.5 3943.2 4006.5 4468.7 4552.5 4578.8 2241.5 2496.8 2593.9 2663.3 2671.6 4198.0 4554.8 4944.0 5203.9 5213.8 4569.5 4620.1 4824.5 5143.4 5230.0 3989.6 4413.8 5124.1 5189.0 5209.7 4649.7 4797.2 4847.1 5022.9 5042.2 4651.9 4847.7 4898.6 4939.8 4978.9 4535.2 4924.8 4981.5 5171.7 5207.7 3471.3 3490.6 3499.0 3505.0 3511.5 4778.7 4958.2 5055.6 5068.9 5075.7 5160.2 5707.6 5821.7 5915.1 5916.2 5157.0 5827.6 5845.6 5868.8 5877.9 5363.7 5710.9 5718.5 5736.3 5772.9 5464.9 5717.7 5864.6 5894.6 5903.2 5140.8 5183.0 5673.7 5775.3 5788.9 10:30:29 INFO - PROCESS | 1652 | 10:30:29 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:24763.97 Median:3582.96 stddev:39653.86 (1106.7%) stddev-sans-first:39724.08 10:30:29 INFO - PROCESS | 1652 | Values: 741.6 741.7 766.8 802.1 829.3 14719.0 16135.2 16157.8 16174.2 16189.9 14180.6 14307.7 14315.6 14321.9 14332.9 711.1 734.6 886.3 890.4 912.9 902.5 915.1 915.2 920.2 920.5 968.1 968.7 971.2 971.7 973.0 760.9 942.8 962.3 964.5 965.9 714.6 715.2 715.4 718.8 721.3 15414.8 15421.0 15424.3 15429.5 15451.4 11907.4 14515.4 14530.5 14623.9 14632.0 11396.8 11743.2 12816.6 13128.6 13228.0 4630.8 4675.5 4794.0 4851.4 4862.9 82303.8 109863.0 111162.0 111472.4 113807.0 11410.0 11501.9 11503.1 11512.7 12039.0 23356.4 23388.0 23422.4 23435.3 23457.4 7992.2 8013.4 8086.7 8226.6 8232.1 3799.3 4312.4 4327.9 4330.1 4364.7 3249.4 3315.1 3344.1 3352.7 3366.6 548.9 561.6 565.1 579.8 607.6 465.5 474.7 600.9 603.9 607.6 8306.7 9406.0 9502.1 9676.2 9699.9 626.4 644.9 677.1 679.6 682.2 4365.5 4591.7 4705.5 4738.6 4858.0 142564.3 143032.6 144687.3 154766.5 155196.0 98279.0 126759.0 132120.0 133215.0 133305.0 113437.4 113754.0 115420.4 115478.8 117909.4 8442.1 8908.2 9006.9 9031.7 9116.6 58311.4 60787.5 61990.0 62120.0 66019.0 89262.0 93717.0 97237.5 99017.5 100709.0 11990.9 12321.6 12406.1 12636.1 12784.7 11454.0 13376.0 13447.0 13649.3 13872.0 9865.4 12084.0 12221.1 12238.1 12649.8 10149.6 12137.3 12587.9 12645.4 12855.9 12068.5 12365.4 12436.6 12638.3 12640.2 10119.7 10314.4 10352.0 10639.5 10694.8 9555.3 9925.0 10634.9 10665.3 10828.9 10:30:29 INFO - PROCESS | 1652 | -------- Summary: end -------- 10:30:29 INFO - PROCESS | 1652 | 10:30:30 INFO - TEST-INFO | 1652: exit 0 10:30:30 INFO - TEST-OK | dromaeo_css | took 1116731ms 10:30:30 INFO - TEST-START | kraken 10:30:30 INFO - operating with platform_type : mac_ 10:30:30 INFO - Initialising browser for kraken test... 10:30:30 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmp1lImhu/profile http://localhost:49267/getInfo.html) 10:30:32 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 10:30:32 INFO - PROCESS | 1660 | colorDepth:24 10:30:32 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 10:30:32 INFO - PROCESS | 1660 | __metrics 10:30:32 INFO - PROCESS | 1660 | 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" 10:30:32 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:30:33 INFO - TEST-INFO | 1660: exit 0 10:30:33 INFO - Browser initialized. 10:30:33 INFO - Running cycle 1/1 for kraken test... 10:30:33 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmp1lImhu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:45 INFO - PROCESS | 1661 | RSS: Main: 245501952 10:30:45 INFO - PROCESS | 1661 | 10:30:47 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 10:30:48 INFO - PROCESS | 1661 | RSS: Main: 295198720 10:30:48 INFO - PROCESS | 1661 | 10:30:51 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 10:30:51 INFO - PROCESS | 1661 | RSS: Main: 305336320 10:30:51 INFO - PROCESS | 1661 | 10:30:55 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 10:30:56 INFO - PROCESS | 1661 | RSS: Main: 390172672 10:30:56 INFO - PROCESS | 1661 | 10:30:58 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 10:30:58 INFO - PROCESS | 1661 | RSS: Main: 292421632 10:30:58 INFO - PROCESS | 1661 | 10:31:00 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:31:01 INFO - PROCESS | 1661 | RSS: Main: 296484864 10:31:01 INFO - PROCESS | 1661 | 10:31:04 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 10:31:04 INFO - PROCESS | 1661 | RSS: Main: 333082624 10:31:04 INFO - PROCESS | 1661 | 10:31:07 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 10:31:08 INFO - PROCESS | 1661 | RSS: Main: 335626240 10:31:08 INFO - PROCESS | 1661 | 10:31:11 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 10:31:11 INFO - PROCESS | 1661 | RSS: Main: 331964416 10:31:11 INFO - PROCESS | 1661 | 10:31:13 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:31:13 INFO - PROCESS | 1661 | RSS: Main: 311787520 10:31:13 INFO - PROCESS | 1661 | 10:31:15 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:31:16 INFO - PROCESS | 1661 | RSS: Main: 318889984 10:31:16 INFO - PROCESS | 1661 | 10:31:18 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:31:19 INFO - PROCESS | 1661 | RSS: Main: 316112896 10:31:19 INFO - PROCESS | 1661 | 10:31:22 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:31:22 INFO - PROCESS | 1661 | RSS: Main: 326037504 10:31:22 INFO - PROCESS | 1661 | 10:31:25 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:31:26 INFO - PROCESS | 1661 | RSS: Main: 328687616 10:31:26 INFO - PROCESS | 1661 | 10:31:27 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 10:31:28 INFO - PROCESS | 1661 | RSS: Main: 372473856 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | __start_tp_report 10:31:28 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 10:31:28 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 10:31:28 INFO - PROCESS | 1661 | |i|pagename|runs| 10:31:28 INFO - PROCESS | 1661 | |0;ai-astar;102;113;112;113;113;112;113;112;111;124 10:31:28 INFO - PROCESS | 1661 | |1;audio-beat-detection;139;108;106;159;107;102;127;104;139;110 10:31:28 INFO - PROCESS | 1661 | |2;audio-dft;182;184;185;184;184;184;179;183;184;183 10:31:28 INFO - PROCESS | 1661 | |3;audio-fft;79;75;58;88;59;58;62;63;82;56 10:31:28 INFO - PROCESS | 1661 | |4;audio-oscillator;86;85;92;72;74;68;95;69;67;100 10:31:28 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;93;129;111;84;86;83;86;83;87;83 10:31:28 INFO - PROCESS | 1661 | |6;imaging-darkroom;93;93;93;93;93;92;92;101;130;92 10:31:28 INFO - PROCESS | 1661 | |7;imaging-desaturate;85;84;83;84;82;82;83;83;85;85 10:31:28 INFO - PROCESS | 1661 | |8;json-parse-financial;54;52;53;52;54;54;53;51;54;52 10:31:28 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;68;71;86;78;73;71;72;73;73;73 10:31:28 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;83;84;83;83;82;82;82;81;83;83 10:31:28 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;136;133;131;136;134;135;135;149;244;151 10:31:28 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;169;166;166;164;167;165;166;164;166;170 10:31:28 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;67;67;67;67;67;65;66;66;66;65 10:31:28 INFO - PROCESS | 1661 | __end_tp_report 10:31:28 INFO - PROCESS | 1661 | __start_cc_report 10:31:28 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,2111 10:31:28 INFO - PROCESS | 1661 | __end_cc_report 10:31:28 INFO - PROCESS | 1661 | __startTimestamp1469035888209__endTimestamp 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | ------- Summary: start ------- 10:31:28 INFO - PROCESS | 1661 | Number of tests: 14 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:5.23 (4.6%) stddev-sans-first:3.94 10:31:28 INFO - PROCESS | 1661 | Values: 102.0 113.0 112.0 113.0 113.0 112.0 113.0 112.0 111.0 124.0 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:120.10 Median:118.50 stddev:19.67 (16.6%) stddev-sans-first:19.63 10:31:28 INFO - PROCESS | 1661 | Values: 139.0 108.0 106.0 159.0 107.0 102.0 127.0 104.0 139.0 110.0 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:183.20 Median:184.00 stddev:1.69 (0.9%) stddev-sans-first:1.73 10:31:28 INFO - PROCESS | 1661 | Values: 182.0 184.0 185.0 184.0 184.0 184.0 179.0 183.0 184.0 183.0 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:68.00 Median:69.00 stddev:11.79 (17.1%) stddev-sans-first:11.82 10:31:28 INFO - PROCESS | 1661 | Values: 79.0 75.0 58.0 88.0 59.0 58.0 62.0 63.0 82.0 56.0 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:80.80 Median:79.50 stddev:12.28 (15.4%) stddev-sans-first:12.88 10:31:28 INFO - PROCESS | 1661 | Values: 86.0 85.0 92.0 72.0 74.0 68.0 95.0 69.0 67.0 100.0 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:85.00 stddev:15.39 (18.1%) stddev-sans-first:16.33 10:31:28 INFO - PROCESS | 1661 | Values: 93.0 129.0 111.0 84.0 86.0 83.0 86.0 83.0 87.0 83.0 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:97.20 Median:93.00 stddev:11.83 (12.7%) stddev-sans-first:12.45 10:31:28 INFO - PROCESS | 1661 | Values: 93.0 93.0 93.0 93.0 93.0 92.0 92.0 101.0 130.0 92.0 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:83.60 Median:84.00 stddev:1.17 (1.4%) stddev-sans-first:1.13 10:31:28 INFO - PROCESS | 1661 | Values: 85.0 84.0 83.0 84.0 82.0 82.0 83.0 83.0 85.0 85.0 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.50 stddev:1.10 (2.1%) stddev-sans-first:1.09 10:31:28 INFO - PROCESS | 1661 | Values: 54.0 52.0 53.0 52.0 54.0 54.0 53.0 51.0 54.0 52.0 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:73.00 stddev:4.96 (6.8%) stddev-sans-first:4.80 10:31:28 INFO - PROCESS | 1661 | Values: 68.0 71.0 86.0 78.0 73.0 71.0 72.0 73.0 73.0 73.0 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:0.84 (1.0%) stddev-sans-first:0.88 10:31:28 INFO - PROCESS | 1661 | Values: 83.0 84.0 83.0 83.0 82.0 82.0 82.0 81.0 83.0 83.0 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:148.40 Median:136.00 stddev:34.25 (25.2%) stddev-sans-first:36.04 10:31:28 INFO - PROCESS | 1661 | Values: 136.0 133.0 131.0 136.0 134.0 135.0 135.0 149.0 244.0 151.0 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.00 stddev:1.95 (1.2%) stddev-sans-first:1.80 10:31:28 INFO - PROCESS | 1661 | Values: 169.0 166.0 166.0 164.0 167.0 165.0 166.0 164.0 166.0 170.0 10:31:28 INFO - PROCESS | 1661 | 10:31:28 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 10:31:28 INFO - PROCESS | 1661 | Values: 67.0 67.0 67.0 67.0 67.0 65.0 66.0 66.0 66.0 65.0 10:31:28 INFO - PROCESS | 1661 | -------- Summary: end -------- 10:31:28 INFO - PROCESS | 1661 | 10:31:29 INFO - TEST-INFO | 1661: exit 0 10:31:29 INFO - TEST-OK | kraken | took 58795ms 10:31:29 INFO - SUITE-END | took 1175s 10:31:29 INFO - Completed test suite (00:19:35) 10:31:29 INFO - javascript benchmark 10:31:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2890.9999999999995, 3366.848491817868, 3383.9002324244625, 3403.115190050586, 3440.3807314683345, 5614.691191984444, 5648.6893220872935, 5691.971540142294, 5724.742386592603, 5726.942730572693, 5700.287464066992, 5750.281214848144, 5751.281089863767, 5760.193572899798, 5771.567132465071, 5174.948250517485, 5222.869428264305, 5249.42256351801, 5255.789768409278, 5310.0441920454305, 5228.424873263938, 5264.6051546134, 5265.368155821307, 5275.314209152804, 5279.234510995903, 5191.377034755816, 5196.324477817897, 5225.16397376418, 5236.659617124875, 5252.606054545905, 5285.709285989288, 5335.839924802262, 5340.91988620171, 5346.35791143945, 5362.088444964326, 5089.643724939256, 5130.97434512825, 5135.050015747099, 5252.185911183773, 5288.814891478818, 5665.830025099253, 5676.914846277309, 5700.743466543974, 5701.059325211335, 5729.0, 6254.0, 6259.906101408483, 6267.8746425071695, 6279.403456671609, 6295.748170073191, 6118.1434599156155, 6238.376162383771, 6301.1493448384335, 6308.747650093991, 6323.588966717149, 5886.705664716747, 5908.084246941731, 5917.615355001911, 5919.82240532789, 5930.377310382434, 5362.8659283517445, 6317.210348706411, 6321.336259692758, 6330.905036424458, 6337.714802833883, 6003.669798161143, 6080.665563393967, 6104.822969073539, 6163.599366041193, 6207.6275423474735, 5252.632315737862, 6317.178766760384, 6322.0, 6329.208848893888, 6333.366663333722, 6225.595336303126, 6253.843653908598, 6258.9374106259265, 6272.498200143978, 6289.842753931189, 6102.640737559575, 6172.043333283348, 6203.503719702413, 6298.464630506367, 6301.558890877594, 4970.478099799469, 4988.72562009093, 5010.724410157476, 5028.472010438924, 5029.497050294941, 4473.418455600751, 4511.142882852248, 4576.748278844696, 4611.216093264086, 4626.976865115653, 5800.187973683687, 5823.039198532195, 5828.475437210672, 5855.590108692436, 5907.734151963172, 6145.002874065857, 6302.023186406114, 6328.715522538731, 6353.237611486558, 6392.456641185551, 4893.0, 5713.285839270091, 5751.827445176651, 5839.124131380242, 5842.737076831553, 5463.016657001698, 5478.342598888159, 5489.34127904646, 5489.890202195934, 5523.143912693539, 6265.530085243625, 6326.905096423649, 6340.302566717565, 6341.809745707544, 6348.301686814447, 6154.415330543591, 6225.595336303307, 6277.1525844010475, 6300.905486417616, 6313.116163736989, 5347.385050719217, 6311.96844015777, 6322.778702745381, 6322.841928951813, 6331.9366806331345, 6175.570346476937, 6233.407826256498, 6237.407446292595, 6254.093156492192, 6263.467605253422, 5738.340090889435, 6123.173371594778, 6242.157308763259, 6272.2159730033745, 6329.461995730415, 5139.511746384088, 6138.5396095292135, 6182.350853160354, 6194.38056194377, 6211.720472578654, 6144.262688477412, 6155.415235552616, 6169.753209871735, 6171.352008039271, 6176.969115154396, 5885.646861188342, 6016.699165041643, 6050.848728781815, 6053.818385448443, 6092.994655881907, 6156.476699480594, 6162.414570615784, 6166.537509686702, 6181.84545386369, 6182.289036760651, 6019.0, 6047.667378294236, 6072.042188477599, 6076.635401875901, 6082.239720034996], "value": 5723.045709555995, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.49757739837526, 518.0054295752155, 534.8689571055093, 544.9019176548222, 558.4136656510663, 31051.68948310516, 31179.064628061165, 43533.564664353384, 44361.556384436146, 44510.77744611273, 45742.0, 46070.0, 46080.0, 46159.538404615945, 46326.768366158205, 9738.513074346272, 9908.653197138101, 9926.305158638897, 9943.10512053915, 9958.651447199349, 8759.299256059532, 8945.686900958468, 9874.308798384116, 10735.624253151142, 11352.829707554394, 12202.694932626711, 12280.324582147978, 12310.507579696801, 12317.568885089024, 12325.013998880067, 12029.639110826689, 12169.391530423443, 12169.756604867942, 12184.02527797774, 12195.939020304842, 8721.60752766127, 11665.24175928562, 11896.345700986441, 11918.821217681654, 12075.758484830341, 43279.783601082105, 43697.12605747867, 43729.781351093356, 43775.12449751019, 43826.78086609578, 3558.395072837624, 3622.4023036198996, 3727.1986522897437, 3728.179800443925, 3850.466918733322, 33422.164445888804, 33770.0, 33963.830180848934, 34072.659273407444, 34110.0, 3309.9834500827583, 3314.320564284316, 3347.2134048498583, 3376.4260075787174, 3454.602720687103, 369843.0, 370236.0, 370563.0, 370795.14602427086, 372322.0, 65166.69666606641, 65591.67204163948, 65632.34367656359, 65797.01304480436, 65854.34145658482, 68372.658136709, 68745.65627171932, 68789.62420751558, 69096.96354554685, 69638.0, 17166.313347465963, 17413.65172696539, 17424.128793560525, 17451.04019278952, 17453.7381939271, 12131.939340303243, 12359.567415140427, 12365.443555040045, 12533.0, 13106.541271055466, 18118.547036323933, 18751.249950001846, 18757.437276881716, 18806.153723082494, 18851.151698173617, 6911.3779759821855, 7296.7446139384865, 7394.334509894028, 7395.670363835375, 7412.147603025721, 964.7491652170346, 1018.7554986803113, 1031.8142734307896, 1063.6277302944063, 1081.6700906223678, 32017.519737203962, 32049.489724591138, 32155.35689286248, 32439.51340729891, 32739.0, 1078.9730256743644, 1118.546988469671, 1134.002078171204, 1144.4792619358172, 1184.5676328140166, 13738.587842364745, 16551.172441377883, 16573.50279491617, 16607.00357978525, 17000.744988825176, 672429.0, 674004.0, 676023.0, 679082.0, 680186.0, 63145.684271579266, 63341.0, 63344.683276583324, 63416.04875926865, 63467.0, 1263.7977923532374, 1303.7262174943178, 1385.681293302526, 1401.614555997109, 1437.7771445425976, 24171.51656966886, 28353.43293134167, 29242.415151696423, 32340.029799106065, 34206.315873682885, 59963.40036599578, 60862.695686521285, 60954.08568871559, 60999.390006101145, 61088.694556526934, 627561.0, 630412.0, 630509.0, 631785.0, 632800.0, 24483.51032979295, 27569.03508377197, 27902.72097279001, 28010.579841302806, 28879.56680649834, 49081.06603299893, 49132.01735965332, 49347.50652493429, 49598.75200624118, 51091.744541277054, 33757.98726038223, 36372.27255454929, 40578.79710601428, 41363.965900852716, 42534.787326063175, 39606.80196598999, 40986.79506602448, 41490.37764433475, 42729.5727042738, 42812.78593607012, 40149.0, 40692.0, 41158.588414115475, 41425.37861932013, 41570.79214603908, 35507.0, 35692.82153589215, 36738.26523469569, 36839.44740828836, 37031.814840925625, 26364.0, 26722.7974741141, 26735.0, 26799.598006030315, 27172.228740600014], "value": 21142.00556452423, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.58801554243735, 384.9326367885621, 387.36085458992665, 399.9240144372569, 422.7611399559249, 15684.52946411608, 17397.82602173978, 20756.584868302623, 21261.787382126175, 21294.0, 17916.55208619785, 17931.462056138305, 21565.0, 21921.342359729195, 21959.451013724665, 5813.447722466359, 5931.673757943322, 6019.909701354483, 6126.417990290915, 6178.598391104586, 6057.273127224739, 6152.876942461148, 6154.323024467305, 6160.260768707762, 6167.660778657172, 5371.248025276464, 5768.538516918637, 5970.626755846158, 6046.365131661156, 6112.602680825732, 6123.755049798003, 6126.356732543063, 6127.632342059491, 6135.233095863017, 6142.293636231823, 5163.586913046947, 5399.838004859821, 5472.398036216013, 5512.255845460852, 5525.4474552544825, 12629.115961882671, 12873.098883078188, 16382.75425868613, 25706.10028649007, 26013.479730405284, 2130.88280144592, 2219.2454565447824, 2299.1033496936207, 2366.290112966103, 2414.6740190074293, 9198.770030749218, 9595.856062159004, 9913.553890074963, 10092.0, 10109.696709098738, 1823.717323814811, 1834.0829585207396, 1838.5771272607242, 1844.6402951424477, 1895.649304878602, 120595.0, 125173.0, 126927.0, 127318.0, 130360.99999999905, 9316.906830931739, 9504.95247523758, 10031.0, 10064.547095380725, 10181.54183061764, 12458.0, 12525.0, 12554.058445616616, 12565.93717031409, 12619.684507887192, 6721.8655626887185, 8119.959400202961, 8241.299489543337, 8295.0, 8320.500769953822, 8599.0, 8605.440646357967, 8625.741227763177, 8759.255463285692, 8788.912110878937, 3902.551206611276, 3911.061345277113, 3915.353966595537, 3982.5021872265966, 3987.5414327352146, 1474.277603974045, 1890.981090189108, 1946.5425624978118, 1971.6549603819274, 1994.1026538057931, 865.4201684871151, 947.4552132523688, 970.9417434953784, 979.4759803505233, 1005.8239808033711, 20782.27262045821, 22038.371941892383, 22126.0, 22196.0, 22249.77750222477, 943.919766819828, 961.240619910277, 980.8332583460686, 984.3798407003542, 997.7306127345576, 11120.0, 11342.60300889465, 11695.473703683354, 11756.706082347839, 11777.17559770825, 584424.0, 590978.0, 594150.0, 608024.0, 609129.0, 105990.0, 113507.0, 122859.0, 133848.33075834558, 142582.0, 909.1317791509225, 945.6548359848744, 948.5589201021559, 972.9221662267001, 978.2418625565101, 19275.903620481808, 19628.705569416757, 19691.31080412236, 19720.11259493355, 19798.010099495255, 52343.0, 54671.45328546664, 54834.0, 55238.0, 55591.0, 83248.58375708082, 86338.0, 87613.42899282707, 88899.55550222466, 89239.0, 7787.766367008999, 7863.960680196562, 7879.172686867796, 7936.6428510716005, 8279.089300176855, 12032.278063315878, 12909.031822613153, 13176.143550669176, 13373.264470454218, 13457.394417251444, 11265.549378024787, 11345.205835591429, 11422.086233101165, 11471.369074700971, 11633.418329083343, 11124.276922000045, 11405.600803971822, 11527.481263343338, 11657.843298989375, 11731.23746956445, 11410.486528106088, 11627.883721163018, 11893.345865977108, 12012.579559715368, 12026.579069732517, 7941.920580794118, 8053.154418785943, 8183.8772418414965, 8190.918090819016, 8227.382946278933, 9352.906470935204, 11322.94338528302, 11703.707407314545, 11751.353675547927, 11755.353455560027], "value": 9484.71142938466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1559.6256898344393, 1595.8723302135827, 1787.5709829640882, 1887.2073729033805, 1916.6933290673487, 7899.4075444341615, 8129.674813007473, 8496.447730897487, 8925.464472131669, 8930.732078037652, 7499.962500187505, 7621.5427074375575, 8449.788755281106, 8594.09761974993, 8720.476771393705, 2300.4478925057992, 2333.9649905251435, 2335.0, 2336.754640762721, 2337.0301324950124, 2050.0, 2123.830093592509, 2286.0, 2304.665823455598, 2333.8249631277636, 2258.6612008198736, 2319.2926157521947, 2322.407786014564, 2333.5799556079983, 2334.8482348647285, 2295.644175152854, 2313.375388645065, 2324.407276144581, 2325.616273314901, 2328.3247858121294, 2296.494771150361, 2318.594246006959, 2318.802901753353, 2319.3273950554317, 2339.6022676145094, 8820.162084601952, 8881.467111973303, 8884.244839188677, 8892.066333035003, 8908.109189081104, 5082.517160869711, 5193.169092945111, 5251.133562962106, 5254.106801843695, 5257.842264732026, 3330.150811543041, 3484.9651503484893, 3536.398812201932, 3541.3802584547857, 3546.2730140321173, 1023.534291897185, 1057.1437135919853, 1063.8936106389299, 1073.742301847551, 1079.568172730906, 11512.827307590393, 11585.246958947726, 11598.478068486938, 11612.593559225386, 11625.6512304631, 4290.764007979528, 4500.774961251925, 4566.748828814447, 4597.816087356535, 4617.607503362252, 9867.11195992364, 9876.60493580263, 9876.703698889045, 9883.308168428284, 9896.802063958681, 5226.869328266747, 5229.189475631283, 5231.0, 5231.215317702375, 5232.895342093137, 4135.875923722293, 4221.155768846243, 4801.18379875422, 4801.591864691471, 4804.06320767454, 3840.7503512271614, 3866.709996750255, 3924.548676902136, 3964.5638979712207, 3969.6824254059607, 1171.543098191706, 1212.3332167307944, 1212.9393530323448, 1277.5081593586535, 1288.6520639427301, 716.7885473785246, 845.9830803383898, 877.2455688108222, 905.6196397513061, 944.2729098594044, 5787.710614469344, 5921.555883308769, 5944.078667806497, 5976.073708575178, 5987.700614969234, 958.0, 966.7196513011148, 970.4129001953717, 1003.6537394598852, 1031.747221930632, 3570.1967057411875, 3635.818209089535, 3942.7634341939574, 3992.3811809169624, 4091.0999580092334, 10288.845667314996, 10585.0, 10598.31110977784, 10599.311044782064, 10629.4153821539, 10464.319819211727, 10507.159427245802, 10545.261831671864, 10556.630517931835, 10590.099841513558, 6971.407430368476, 6977.197622273402, 7215.891761623579, 7680.9231907680205, 8178.5092894426525, 5756.280464941882, 5852.561057920588, 6046.5767396281835, 6105.9694701526205, 6190.597611155261, 10004.799904001733, 10022.498875056071, 10025.5488503019, 10027.498625068863, 10029.949850250994, 8174.019117705913, 9965.551550180115, 9996.150327222267, 10229.335093218917, 10279.794404111726, 6137.907931381123, 7435.7025718970635, 7437.925620743939, 7456.66445009965, 7458.962705186439, 8100.635471403683, 8102.189781021851, 8139.308158806568, 8188.263056324721, 8211.343092552463, 5899.616524925866, 7480.887786683095, 7553.055868016498, 7704.8459030820195, 7752.418568607264, 7709.498882572615, 7726.690932362642, 7745.845083098419, 7768.184340644151, 7824.726134585262, 6850.965745171242, 6995.685194166376, 7049.189343225595, 7085.504014719127, 7163.534370265916, 5120.385553733576, 5145.794168233228, 5221.556167725786, 5286.762095705625, 5377.542908852792, 5077.365329333833, 5166.121759300852, 5251.317328747238, 5330.173823057432, 5457.808976685797], "value": 4544.84243538258, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.15676106900685, 305.4212267752609, 314.07974634321437, 315.81682624078024, 317.5474948198816, 5136.409312929014, 5345.893082138355, 5504.073574249011, 5577.0, 5620.466055724704, 3952.446657467957, 4702.929456058162, 4803.759812009403, 5412.591396828413, 5481.945180548193, 3449.72402207824, 3673.797941113238, 3872.244912242114, 4061.2689715851134, 4237.597428244312, 3587.497750314958, 4099.815508302118, 4233.618974292313, 4252.893677658052, 4256.2338779019765, 3594.388953877834, 4142.316517774563, 4172.728772629769, 4200.915981680365, 4204.159168166364, 3129.6087989001376, 3411.7782344147677, 3975.8012099394914, 3981.029390451716, 4204.642605378546, 3621.692156166729, 3640.490331353586, 3655.4882316475714, 3656.2687462507606, 3665.4501824726503, 4452.799624016927, 5306.840794776124, 5407.918881216785, 5431.289143919653, 5460.798624302687, 4196.790160491993, 4871.902561948777, 4881.219004959225, 4892.0, 4894.461609222983, 5106.961357991989, 5567.331920169565, 5787.958167529843, 5838.956365272164, 5903.586748927577, 3450.27544215715, 3612.747107702462, 3857.8842634721004, 3943.7239393242485, 3945.4279129526058, 6051.576389652726, 6069.848253793646, 6083.8174854754425, 6087.421694939018, 6103.938960610381, 3992.201559688074, 4020.798960052044, 4038.697097717683, 4041.8989525261513, 4042.3128068227884, 3963.9981809186174, 3970.2059588082498, 3982.9893164609757, 4024.8188831502653, 4062.735922165109, 4213.389058586487, 4529.705569137996, 4753.239481682914, 4769.809207631725, 4792.7363994980615, 5039.7228152451235, 5373.892522149535, 5979.820605381846, 5981.461668449861, 5994.280686317583, 1117.9049780768562, 1244.2658831289582, 1277.4570807406815, 1368.9452421903013, 1379.5654368873772, 816.07783204978, 828.5732847583499, 843.3843294395126, 851.714675583674, 853.0318088969065, 4494.52807455219, 4503.909921801611, 4508.504064552896, 4571.131485017836, 4614.054118905617, 4503.932441013388, 5007.874803129951, 5037.665018770029, 5051.393832740095, 5160.48395160481, 3943.211357728466, 4006.5159601046953, 4468.664850136188, 4552.517324246954, 4578.816847326069, 2241.5429970519294, 2496.7752902238885, 2593.948121037569, 2663.280914153168, 2671.639328690641, 4197.984967215692, 4554.817807287672, 4943.975280123576, 5203.947960520422, 5213.765380557884, 4569.451665800058, 4620.145273124483, 4824.49342819006, 5143.376877792353, 5230.045024561186, 3989.623579864942, 4413.815161495017, 5124.078470573535, 5189.0, 5209.749660081553, 4649.744264065509, 4797.249004113403, 4847.127517046965, 5022.899542009212, 5042.243663450512, 4651.906961860812, 4847.709137451764, 4898.583620392306, 4939.838503357926, 4978.9130738942085, 4535.165521549032, 4924.8276310328965, 4981.452040275639, 5171.741412929263, 5207.71357575337, 3471.2883858808377, 3490.5985811631986, 3498.9825050874583, 3504.9824750876082, 3511.5083888256177, 4778.665493415428, 4958.157113290677, 5055.570276526537, 5068.873278168076, 5075.720835354091, 5160.200168973815, 5707.600467967202, 5821.650700957956, 5915.112733090071, 5916.171735956884, 5157.0, 5827.621204621855, 5845.649261044351, 5868.823935281948, 5877.911831322619, 5363.704996225245, 5710.914336284876, 5718.542516598745, 5736.307789202112, 5772.864040305114, 5464.863378415572, 5717.714114294352, 5864.595515838486, 5894.646321220741, 5903.203067585821, 5140.794368225379, 5183.0, 5673.74468148926, 5775.27809023872, 5788.913166302593], "value": 3965.584915916622, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.6403044523408, 741.7107328142025, 766.8351304469542, 802.0776107476399, 829.3489610655629, 14719.0, 16135.193240337965, 16157.757633635505, 16174.19129043549, 16189.919050404746, 14180.645483862909, 14307.713845723105, 14315.642108947282, 14321.856781432209, 14332.928335358334, 711.1359697966969, 734.6290123487631, 886.3042511628373, 890.4479222881806, 912.9497877616728, 902.512643172686, 915.0849150849151, 915.244922938575, 920.1580553793272, 920.5397301349325, 968.1045033344163, 968.6609686609665, 971.159946646153, 971.68905950096, 973.0221127766584, 760.8896709977022, 942.8350038743192, 962.3023308101606, 964.4936408385583, 965.8985806490358, 714.5962531169924, 715.181117620327, 715.4455297144702, 718.8310746974457, 721.2787212787213, 15414.845851541453, 15421.0, 15424.305906234134, 15429.459968901034, 15451.38194472231, 11907.404629768564, 14515.419383224764, 14530.491432799907, 14623.926880365636, 14632.0, 11396.829047564293, 11743.236689615147, 12816.55142070023, 13128.60614181576, 13228.0, 4630.837920672794, 4675.485696573374, 4793.976030119827, 4851.393575803025, 4862.902741945177, 82303.7654435184, 109863.0, 111162.0, 111472.4426377871, 113807.0, 11410.0, 11501.942490287494, 11503.137264705181, 11512.712182195512, 12039.0, 23356.416089597555, 23388.0, 23422.414439639146, 23435.296941091452, 23457.41356466102, 7992.160823113606, 8013.439059265912, 8086.7169649062, 8226.62980165882, 8232.135625759209, 3799.297130030953, 4312.439382880206, 4327.870163895088, 4330.133973205371, 4364.6944713869725, 3249.415105281072, 3315.1380641033024, 3344.1138098403944, 3352.664733526628, 3366.629670736217, 548.8885007859117, 561.6405500479697, 565.104309669179, 579.7847079309793, 607.6475644126396, 465.52283908993553, 474.6985664103319, 600.9188759517409, 603.9456448919618, 607.6293460988793, 8306.70926517569, 9406.0, 9502.144806967406, 9676.225901927828, 9699.854502182472, 626.37988391493, 644.932282110381, 677.1231255524108, 679.5650783498564, 682.2393031769541, 4365.475145615577, 4591.655625828076, 4705.4588722296685, 4738.64460165489, 4857.95142048575, 142564.28717856345, 143032.56967430402, 144687.2765636165, 154766.45233547746, 155196.0, 98279.0, 126759.0, 132120.0, 133214.99999999805, 133305.0, 113437.43281283541, 113754.0, 115420.42289788666, 115478.84521154681, 117909.41045294718, 8442.071372148936, 8908.153725396078, 9006.909930900869, 9031.683891063782, 9116.635334586543, 58311.4168858306, 60787.478454932694, 61990.0, 62120.0, 66019.0, 89262.0, 93717.0, 97237.51381243048, 99017.50491247498, 100709.0, 11990.880091199326, 12321.630351089481, 12406.131570789958, 12636.052296078014, 12784.74430511366, 11454.008304056066, 13376.028090756332, 13447.0, 13649.317534123453, 13872.0, 9865.408075515492, 12084.0, 12221.083418743452, 12238.053659311045, 12649.810252846399, 10149.64476243328, 12137.271763694207, 12587.874121259036, 12645.367731613198, 12855.871441285468, 12068.517259309529, 12365.443555039865, 12436.564720234748, 12638.304893230961, 12640.178388404724, 10119.696409107739, 10314.43270620123, 10352.016558426938, 10639.50253802085, 10694.786104277715, 9555.283353748358, 9924.950375248078, 10634.89365106339, 10665.253432259979, 10828.891711083104], "value": 7772.614213387091, "unit": "score"}], "name": "dromaeo_css", "value": 7374.061406196869, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 112.0, 113.0, 113.0, 112.0, 113.0, 112.0, 111.0, 124.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 108.0, 106.0, 159.0, 107.0, 102.0, 127.0, 104.0, 139.0, 110.0], "value": 120.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 185.0, 184.0, 184.0, 184.0, 179.0, 183.0, 184.0, 183.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 58.0, 88.0, 59.0, 58.0, 62.0, 63.0, 82.0, 56.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 92.0, 72.0, 74.0, 68.0, 95.0, 69.0, 67.0, 100.0], "value": 80.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 129.0, 111.0, 84.0, 86.0, 83.0, 86.0, 83.0, 87.0, 83.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 92.0, 92.0, 101.0, 130.0, 92.0], "value": 97.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 84.0, 82.0, 82.0, 83.0, 83.0, 85.0, 85.0], "value": 83.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 52.0, 54.0, 54.0, 53.0, 51.0, 54.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 86.0, 78.0, 73.0, 71.0, 72.0, 73.0, 73.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 83.0, 82.0, 82.0, 82.0, 81.0, 83.0, 83.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 131.0, 136.0, 134.0, 135.0, 135.0, 149.0, 244.0, 151.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 166.0, 164.0, 167.0, 165.0, 166.0, 164.0, 166.0, 170.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1428.1999999999998, "alertThreshold": 2.0}]} 10:31:29 INFO - Return code: 0 10:31:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:31:29 INFO - # TBPL SUCCESS # 10:31:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:31:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:31:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:31:29 INFO - 2016-07-20 10:31:29.550 screenresolution[1665:10118] starting screenresolution argv=screenresolution get 10:31:29 INFO - 2016-07-20 10:31:29.553 screenresolution[1665:10118] Display 0: 1600x1200x32@60 10:31:29 INFO - 2016-07-20 10:31:29.559 screenresolution[1666:10121] starting screenresolution argv=screenresolution list 10:31:29 INFO - Available Modes on Display 0 10:31:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:31:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:31:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:31:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:31:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:31:29 INFO - Intel Iris: 10:31:29 INFO - Chipset Model: Intel Iris 10:31:29 INFO - Type: GPU 10:31:29 INFO - Bus: Built-In 10:31:29 INFO - VRAM (Dynamic, Max): 1536 MB 10:31:29 INFO - Vendor: Intel (0x8086) 10:31:29 INFO - Device ID: 0x0a2e 10:31:29 INFO - Revision ID: 0x0009 10:31:29 INFO - Displays: 10:31:29 INFO - Display: 10:31:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:31:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:31:29 INFO - Display Serial Number: 1600x1200 60 10:31:29 INFO - Main Display: Yes 10:31:29 INFO - Mirror: Off 10:31:29 INFO - Online: Yes 10:31:29 INFO - Rotation: Supported 10:31:29 INFO - Return code: 0 10:31:29 INFO - Running post-action listener: _resource_record_post_action 10:31:29 INFO - [mozharness: 2016-07-20 17:31:29.794905Z] Finished run-tests step (success) 10:31:29 INFO - Running post-run listener: _resource_record_post_run 10:31:29 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37700608; Write bytes: 703807488; Read time: 384; Write time: 1888 10:31:29 INFO - TinderboxPrint: CPU usage
53.7% 10:31:29 INFO - TinderboxPrint: I/O read bytes / time
37,700,608 / 384 10:31:29 INFO - TinderboxPrint: I/O write bytes / time
703,807,488 / 1,888 10:31:29 INFO - TinderboxPrint: CPU idle
2,241.7 (46.3%) 10:31:29 INFO - TinderboxPrint: CPU system
968.3 (20.0%) 10:31:29 INFO - TinderboxPrint: CPU user
1,631.5 (33.7%) 10:31:29 INFO - TinderboxPrint: Swap in / out
445,771,776 / 0 10:31:29 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 404908544; Write bytes: 393734144; Read time: 29692; Write time: 753 10:31:29 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 30444544; Write bytes: 292358144; Read time: 298; Write time: 1089 10:31:30 INFO - Running post-run listener: _upload_blobber_files 10:31:30 INFO - Blob upload gear active. 10:31:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:31:30 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 10:31:30 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'] 10:31:30 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 10:31:30 INFO - (blobuploader) - INFO - Open directory for files ... 10:31:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:31:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:31:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:31 INFO - (blobuploader) - INFO - Done attempting. 10:31:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:31:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:31:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:32 INFO - (blobuploader) - INFO - Done attempting. 10:31:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:31:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:31:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:39 INFO - (blobuploader) - INFO - Done attempting. 10:31:39 INFO - (blobuploader) - INFO - Iteration through files over. 10:31:39 INFO - Return code: 0 10:31:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:31:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:31:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e084216143bddc5432232d0441929ae4354822245c2d3b5545b01bbe9de682eea18e0481659b5f1856ac9b255e02ecf9b5045293629d26e32db06594c68edf5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2d7f79993e8e47da519742f0b6448784575955b9e44ff7955ad121a984161c809add195fb8096c4cee445ce09b9428f480df2a25042ae00131e3945ab0579c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/262e161d92ca083ed1fb8ca2b80479bc4afb1ed5f0876d61d2063c5c0f24add41b2bf36d352be1d8cefe47bb0920d4820a449d45f0abb3efaaf5693f38510a09"} 10:31:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:31:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:31:39 INFO - Contents: 10:31:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e084216143bddc5432232d0441929ae4354822245c2d3b5545b01bbe9de682eea18e0481659b5f1856ac9b255e02ecf9b5045293629d26e32db06594c68edf5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2d7f79993e8e47da519742f0b6448784575955b9e44ff7955ad121a984161c809add195fb8096c4cee445ce09b9428f480df2a25042ae00131e3945ab0579c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/262e161d92ca083ed1fb8ca2b80479bc4afb1ed5f0876d61d2063c5c0f24add41b2bf36d352be1d8cefe47bb0920d4820a449d45f0abb3efaaf5693f38510a09"} 10:31:39 INFO - Running post-run listener: copy_logs_to_upload_dir 10:31:39 INFO - Copying logs to upload dir... 10:31:39 INFO - mkdir: /builds/slave/test/build/upload/logs 10:31:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.108875 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-07-20 10:31:39.978357) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 10:31:39.982143) ========= 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.aEkEef3flf/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.Q4yzg2Obxa/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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/e084216143bddc5432232d0441929ae4354822245c2d3b5545b01bbe9de682eea18e0481659b5f1856ac9b255e02ecf9b5045293629d26e32db06594c68edf5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2d7f79993e8e47da519742f0b6448784575955b9e44ff7955ad121a984161c809add195fb8096c4cee445ce09b9428f480df2a25042ae00131e3945ab0579c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/262e161d92ca083ed1fb8ca2b80479bc4afb1ed5f0876d61d2063c5c0f24add41b2bf36d352be1d8cefe47bb0920d4820a449d45f0abb3efaaf5693f38510a09"} build_url:https://queue.taskcluster.net/v1/task/Q-bGwnCbQSCAc37xP4rDaw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011030 build_url: 'https://queue.taskcluster.net/v1/task/Q-bGwnCbQSCAc37xP4rDaw/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/e084216143bddc5432232d0441929ae4354822245c2d3b5545b01bbe9de682eea18e0481659b5f1856ac9b255e02ecf9b5045293629d26e32db06594c68edf5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2d7f79993e8e47da519742f0b6448784575955b9e44ff7955ad121a984161c809add195fb8096c4cee445ce09b9428f480df2a25042ae00131e3945ab0579c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/262e161d92ca083ed1fb8ca2b80479bc4afb1ed5f0876d61d2063c5c0f24add41b2bf36d352be1d8cefe47bb0920d4820a449d45f0abb3efaaf5693f38510a09"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 10:31:40.057474) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:31:40.057826) ========= 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.aEkEef3flf/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.Q4yzg2Obxa/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.005087 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:31:40.082232) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 10:31:40.082533) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 10:31:40.082841) ========= ========= Total master_lag: 0.27 =========