builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0100 starttime: 1461408141.21 results: success (0) buildid: 20160423014751 builduid: 4a551be9d5ae4526a36020d2fad26a6a revision: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:21.208265) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:21.208634) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:21.209353) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:21.228465) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:21.228745) ========= 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.FEml56lpWq/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.H8lL0Qgwnu/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-04-23 03:42:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.9M=0.001s 2016-04-23 03:42:21 (21.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.533536 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:21.776286) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:21.776632) ========= 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.FEml56lpWq/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.H8lL0Qgwnu/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.020002 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:21.825758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 03:42:21.826121) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 --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 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FEml56lpWq/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.H8lL0Qgwnu/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-04-23 03:42:21,901 truncating revision to first 12 chars 2016-04-23 03:42:21,901 Setting DEBUG logging. 2016-04-23 03:42:21,902 attempt 1/10 2016-04-23 03:42:21,902 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37f04460ddb7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 03:42:23,628 unpacking tar archive at: mozilla-central-37f04460ddb7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.978694 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 03:42:23.822762) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:23.823109) ========= script_repo_revision: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:23.823555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:23.823829) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:23.837632) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-04-23 03:42:23.837949) ========= /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.FEml56lpWq/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.H8lL0Qgwnu/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:42:24 INFO - MultiFileLogger online at 20160423 03:42:24 in /builds/slave/test 03:42:24 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 03:42:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:42:24 INFO - {'append_to_log': False, 03:42:24 INFO - 'base_work_dir': '/builds/slave/test', 03:42:24 INFO - 'blob_upload_branch': 'Firefox', 03:42:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:42:24 INFO - 'branch': 'Firefox', 03:42:24 INFO - 'buildbot_json_path': 'buildprops.json', 03:42:24 INFO - 'config_files': ('talos/mac_config.py',), 03:42:24 INFO - 'default_actions': ('clobber', 03:42:24 INFO - 'read-buildbot-config', 03:42:24 INFO - 'download-and-extract', 03:42:24 INFO - 'populate-webroot', 03:42:24 INFO - 'create-virtualenv', 03:42:24 INFO - 'install', 03:42:24 INFO - 'run-tests'), 03:42:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:42:24 INFO - 'download_minidump_stackwalk': True, 03:42:24 INFO - 'download_symbols': 'ondemand', 03:42:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:42:24 INFO - 'tooltool.py': '/tools/tooltool.py', 03:42:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:42:24 INFO - '/tools/misc-python/virtualenv.py')}, 03:42:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:42:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:42:24 INFO - 'installer_path': 'installer.exe', 03:42:24 INFO - 'log_level': 'info', 03:42:24 INFO - 'log_name': 'talos', 03:42:24 INFO - 'log_to_console': True, 03:42:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:42:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:42:24 INFO - 'opt_config_files': (), 03:42:24 INFO - 'pip_index': False, 03:42:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:42:24 INFO - 'cmd': ('bash', 03:42:24 INFO - '-c', 03:42:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:42:24 INFO - 'enabled': True, 03:42:24 INFO - 'halt_on_failure': False, 03:42:24 INFO - 'name': 'check_screen_resolution'},), 03:42:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:42:24 INFO - 'cmd': ('bash', 03:42:24 INFO - '-c', 03:42:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:42:24 INFO - 'enabled': True, 03:42:24 INFO - 'halt_on_failure': False, 03:42:24 INFO - 'name': 'check_screen_resolution'},), 03:42:24 INFO - 'run_cmd_checks_enabled': True, 03:42:24 INFO - 'sps_profile': False, 03:42:24 INFO - 'sps_profile_interval': 0, 03:42:24 INFO - 'suite': 'dromaeojs', 03:42:24 INFO - 'system_bits': '32', 03:42:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:42:24 INFO - 'title': 't-yosemite-r7-0100', 03:42:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:42:24 INFO - 'use_talos_json': True, 03:42:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:42:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:42:24 INFO - 'work_dir': 'build'} 03:42:24 INFO - ##### 03:42:24 INFO - ##### Running clobber step. 03:42:24 INFO - ##### 03:42:24 INFO - Running pre-action listener: _resource_record_pre_action 03:42:24 INFO - Running main action method: clobber 03:42:24 INFO - rmtree: /builds/slave/test/build 03:42:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:42:25 INFO - Running post-action listener: _resource_record_post_action 03:42:25 INFO - ##### 03:42:25 INFO - ##### Running read-buildbot-config step. 03:42:25 INFO - ##### 03:42:25 INFO - Running pre-action listener: _resource_record_pre_action 03:42:25 INFO - Running main action method: read_buildbot_config 03:42:25 INFO - Using buildbot properties: 03:42:25 INFO - { 03:42:25 INFO - "project": "", 03:42:25 INFO - "product": "firefox", 03:42:25 INFO - "script_repo_revision": "production", 03:42:25 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:42:25 INFO - "repository": "", 03:42:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:42:25 INFO - "buildid": "20160423014751", 03:42:25 INFO - "pgo_build": "False", 03:42:25 INFO - "basedir": "/builds/slave/test", 03:42:25 INFO - "buildnumber": 229, 03:42:25 INFO - "slavename": "t-yosemite-r7-0100", 03:42:25 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:42:25 INFO - "platform": "yosemite_r7", 03:42:25 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:42:25 INFO - "branch": "mozilla-central", 03:42:25 INFO - "repo_path": "mozilla-central", 03:42:25 INFO - "revision": "37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776", 03:42:25 INFO - "stage_platform": "macosx64", 03:42:25 INFO - "builduid": "4a551be9d5ae4526a36020d2fad26a6a", 03:42:25 INFO - "slavebuilddir": "test" 03:42:25 INFO - } 03:42:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 03:42:25 INFO - Running post-action listener: _resource_record_post_action 03:42:25 INFO - ##### 03:42:25 INFO - ##### Running download-and-extract step. 03:42:25 INFO - ##### 03:42:25 INFO - Running pre-action listener: _resource_record_pre_action 03:42:25 INFO - Running main action method: download_and_extract 03:42:25 INFO - mkdir: /builds/slave/test/build/tests 03:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:42:25 INFO - https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:42:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:42:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:42:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 03:42:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 03:42:39 INFO - Downloaded 1199 bytes. 03:42:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 03:42:39 INFO - Using the following test package requirements: 03:42:39 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:42:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:39 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 03:42:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:39 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 03:42:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:39 INFO - u'jsshell-mac.zip'], 03:42:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:39 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 03:42:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:42:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:39 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 03:42:39 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:39 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 03:42:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:39 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 03:42:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:39 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 03:42:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:42:39 INFO - https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:42:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:42:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:42:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:42:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:42:42 INFO - Downloaded 18109620 bytes. 03:42:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:42:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:42:45 INFO - Return code: 0 03:42:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:42:45 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')]} 03:42:45 INFO - https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:42:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:42:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:42:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:42:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:42:46 INFO - Downloaded 18109620 bytes. 03:42:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:42:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:42:50 INFO - Return code: 0 03:42:50 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')]} 03:42:50 INFO - https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:42:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:42:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:42:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:42:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:42:51 INFO - Downloaded 10840145 bytes. 03:42:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:42:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:42:51 INFO - Return code: 0 03:42: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')]} 03:42:51 INFO - https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:42:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:42:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:42:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 03:42:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 03:42:54 INFO - Downloaded 110134522 bytes. 03:42:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:42:54 INFO - mkdir: /builds/slave/test/properties 03:42:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:42:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:42:54 INFO - Contents: 03:42:54 INFO - build_url:https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:42:55 INFO - Running post-action listener: _resource_record_post_action 03:42:55 INFO - Running post-action listener: set_extra_try_arguments 03:42:55 INFO - ##### 03:42:55 INFO - ##### Running populate-webroot step. 03:42:55 INFO - ##### 03:42:55 INFO - Running pre-action listener: _resource_record_pre_action 03:42:55 INFO - Running main action method: populate_webroot 03:42:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:42:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:42:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:42:55 INFO - '--tppagecycles', 03:42:55 INFO - '7'], 03:42:55 INFO - 'tests': ['tsvgm']}}, 03:42:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:42:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:42:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:42:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:42:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:42:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:42:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:55 INFO - 'talos_options': ['--disable-e10s'], 03:42:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:42:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:42:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:55 INFO - 'talos_options': ['--disable-e10s'], 03:42:55 INFO - 'tests': ['damp', 'tps']}, 03:42:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:55 INFO - 'tests': ['damp', 'tps']}, 03:42:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:42:55 INFO - 'tests': ['dromaeo_dom']}, 03:42:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:42:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:42:55 INFO - 'tests': ['a11yr', 03:42:55 INFO - 'ts_paint', 03:42:55 INFO - 'tpaint', 03:42:55 INFO - 'sessionrestore', 03:42:55 INFO - 'sessionrestore_no_auto_restore', 03:42:55 INFO - 'tabpaint']}, 03:42:55 INFO - 'other-e10s': {'tests': ['a11yr', 03:42:55 INFO - 'ts_paint', 03:42:55 INFO - 'tpaint', 03:42:55 INFO - 'sessionrestore', 03:42:55 INFO - 'sessionrestore_no_auto_restore', 03:42:55 INFO - 'tabpaint']}, 03:42:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:42:55 INFO - 'ts_paint', 03:42:55 INFO - 'tpaint', 03:42:55 INFO - 'sessionrestore', 03:42:55 INFO - 'sessionrestore_no_auto_restore', 03:42:55 INFO - 'tabpaint']}, 03:42:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:42:55 INFO - 'ts_paint', 03:42:55 INFO - 'tpaint', 03:42:55 INFO - 'sessionrestore', 03:42:55 INFO - 'sessionrestore_no_auto_restore', 03:42:55 INFO - 'tabpaint']}, 03:42:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:42:55 INFO - 'tests': ['a11yr', 03:42:55 INFO - 'ts_paint', 03:42:55 INFO - 'tpaint', 03:42:55 INFO - 'sessionrestore', 03:42:55 INFO - 'sessionrestore_no_auto_restore', 03:42:55 INFO - 'tabpaint']}, 03:42:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:42:55 INFO - 'tests': ['a11yr', 03:42:55 INFO - 'ts_paint', 03:42:55 INFO - 'tpaint', 03:42:55 INFO - 'sessionrestore', 03:42:55 INFO - 'sessionrestore_no_auto_restore', 03:42:55 INFO - 'tabpaint']}, 03:42:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:42:55 INFO - 'tests': ['tsvgx', 03:42:55 INFO - 'tsvgr_opacity', 03:42:55 INFO - 'tart', 03:42:55 INFO - 'tscrollx', 03:42:55 INFO - 'cart']}, 03:42:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:42:55 INFO - 'tsvgr_opacity', 03:42:55 INFO - 'tart', 03:42:55 INFO - 'tscrollx', 03:42:55 INFO - 'cart']}, 03:42:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:55 INFO - 'talos_options': ['--disable-e10s'], 03:42:55 INFO - 'tests': ['tp5o']}, 03:42:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:55 INFO - 'tests': ['tp5o']}, 03:42:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:55 INFO - 'talos_options': ['--disable-e10s', 03:42:55 INFO - '--xperf_path', 03:42:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:42:55 INFO - 'tests': ['tp5n']}, 03:42:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:55 INFO - 'talos_options': ['--xperf_path', 03:42:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:42:55 INFO - 'tests': ['tp5n']}}, 03:42:55 INFO - 'talos.zip': {'path': '', 03:42:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:42:55 INFO - Running post-action listener: _resource_record_post_action 03:42:55 INFO - ##### 03:42:55 INFO - ##### Running create-virtualenv step. 03:42:55 INFO - ##### 03:42:55 INFO - Running pre-action listener: _resource_record_pre_action 03:42:55 INFO - Running main action method: create_virtualenv 03:42:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:42:55 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 03:42:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:42:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:42:55 INFO - Using real prefix '/tools/python27' 03:42:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:42:56 INFO - Installing distribute.............................................................................................................................................................................................done. 03:42:59 INFO - Installing pip.................done. 03:42:59 INFO - Return code: 0 03:42:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:42: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')]} 03:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42: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')]} 03:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10768da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10769d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0da565cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752ce00>, '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 0x107355db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107527b20>, '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.FEml56lpWq/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.H8lL0Qgwnu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:42: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', 'pip>=1.5'] in /builds/slave/test/build 03:42: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 pip>=1.5 03:42:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FEml56lpWq/Render', 03:42:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:59 INFO - 'HOME': '/Users/cltbld', 03:42:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:59 INFO - 'LOGNAME': 'cltbld', 03:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:59 INFO - 'MOZ_NO_REMOTE': '1', 03:42:59 INFO - 'NO_EM_RESTART': '1', 03:42:59 INFO - 'PAGER': '/bin/cat', 03:42:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:59 INFO - 'PWD': '/builds/slave/test', 03:42:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:59 INFO - 'SHELL': '/bin/bash', 03:42:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8lL0Qgwnu/Listeners', 03:42:59 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:42:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:59 INFO - 'USER': 'cltbld', 03:42:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:59 INFO - 'XPC_FLAGS': '0x0', 03:42:59 INFO - 'XPC_SERVICE_NAME': '0', 03:42:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:59 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 03:42:59 INFO - Cleaning up... 03:42:59 INFO - Return code: 0 03:42:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:42: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')]} 03:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42: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')]} 03:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10768da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10769d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0da565cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752ce00>, '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 0x107355db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107527b20>, '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.FEml56lpWq/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.H8lL0Qgwnu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:42: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', 'psutil>=0.7.1'] in /builds/slave/test/build 03:42: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 psutil>=0.7.1 03:42:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FEml56lpWq/Render', 03:42:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:59 INFO - 'HOME': '/Users/cltbld', 03:42:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:59 INFO - 'LOGNAME': 'cltbld', 03:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:59 INFO - 'MOZ_NO_REMOTE': '1', 03:42:59 INFO - 'NO_EM_RESTART': '1', 03:42:59 INFO - 'PAGER': '/bin/cat', 03:42:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:59 INFO - 'PWD': '/builds/slave/test', 03:42:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:59 INFO - 'SHELL': '/bin/bash', 03:42:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8lL0Qgwnu/Listeners', 03:42:59 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:42:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:59 INFO - 'USER': 'cltbld', 03:42:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:59 INFO - 'XPC_FLAGS': '0x0', 03:42:59 INFO - 'XPC_SERVICE_NAME': '0', 03:42:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:00 INFO - Downloading/unpacking psutil>=0.7.1 03:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:43:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:03 INFO - Installing collected packages: psutil 03:43:03 INFO - Running setup.py install for psutil 03:43:03 INFO - building 'psutil._psutil_osx' extension 03:43:03 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 03:43:03 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 03:43:03 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 03:43:03 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 03:43:03 INFO - building 'psutil._psutil_posix' extension 03:43:03 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 03:43:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:43:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:43:03 INFO - ^ 03:43:03 INFO - 1 warning generated. 03:43:03 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 03:43:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:03 INFO - Successfully installed psutil 03:43:03 INFO - Cleaning up... 03:43:03 INFO - Return code: 0 03:43:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:43: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')]} 03:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43: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')]} 03:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43: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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10768da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10769d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0da565cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752ce00>, '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 0x107355db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107527b20>, '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.FEml56lpWq/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.H8lL0Qgwnu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:43: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:43: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 mozsystemmonitor==0.0.0 03:43:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FEml56lpWq/Render', 03:43:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:03 INFO - 'HOME': '/Users/cltbld', 03:43:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:03 INFO - 'LOGNAME': 'cltbld', 03:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:03 INFO - 'MOZ_NO_REMOTE': '1', 03:43:03 INFO - 'NO_EM_RESTART': '1', 03:43:03 INFO - 'PAGER': '/bin/cat', 03:43:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:03 INFO - 'PWD': '/builds/slave/test', 03:43:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:03 INFO - 'SHELL': '/bin/bash', 03:43:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8lL0Qgwnu/Listeners', 03:43:03 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:43:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:03 INFO - 'USER': 'cltbld', 03:43:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:03 INFO - 'XPC_FLAGS': '0x0', 03:43:03 INFO - 'XPC_SERVICE_NAME': '0', 03:43:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:43:06 INFO - Installing collected packages: mozsystemmonitor 03:43:06 INFO - Running setup.py install for mozsystemmonitor 03:43:06 INFO - Successfully installed mozsystemmonitor 03:43:06 INFO - Cleaning up... 03:43:06 INFO - Return code: 0 03:43:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:43:06 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')]} 03:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:06 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')]} 03:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:06 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 0x10768da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10769d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0da565cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752ce00>, '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 0x107355db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107527b20>, '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.FEml56lpWq/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.H8lL0Qgwnu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:43:06 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 03:43:06 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 03:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FEml56lpWq/Render', 03:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:06 INFO - 'HOME': '/Users/cltbld', 03:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:06 INFO - 'LOGNAME': 'cltbld', 03:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:06 INFO - 'MOZ_NO_REMOTE': '1', 03:43:06 INFO - 'NO_EM_RESTART': '1', 03:43:06 INFO - 'PAGER': '/bin/cat', 03:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:06 INFO - 'PWD': '/builds/slave/test', 03:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:06 INFO - 'SHELL': '/bin/bash', 03:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8lL0Qgwnu/Listeners', 03:43:06 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:06 INFO - 'USER': 'cltbld', 03:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:06 INFO - 'XPC_FLAGS': '0x0', 03:43:06 INFO - 'XPC_SERVICE_NAME': '0', 03:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:07 INFO - Downloading/unpacking blobuploader==1.2.4 03:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:09 INFO - Downloading blobuploader-1.2.4.tar.gz 03:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:43:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:43:09 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 03:43:09 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 03:43:09 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 03:43:09 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 03:43:09 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 03:43:09 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 03:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:43:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:43:10 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 03:43:10 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 03:43:10 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 03:43:10 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 03:43:10 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 03:43:10 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 03:43:10 INFO - Downloading docopt-0.6.1.tar.gz 03:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:43:10 INFO - Installing collected packages: blobuploader, requests, docopt 03:43:10 INFO - Running setup.py install for blobuploader 03:43:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:43:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:43:11 INFO - Running setup.py install for requests 03:43:11 INFO - Running setup.py install for docopt 03:43:11 INFO - Successfully installed blobuploader requests docopt 03:43:11 INFO - Cleaning up... 03:43:11 INFO - Return code: 0 03:43:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:11 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')]} 03:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:11 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')]} 03:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:11 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 0x10768da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10769d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0da565cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752ce00>, '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 0x107355db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107527b20>, '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.FEml56lpWq/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.H8lL0Qgwnu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:43:11 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 03:43:11 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 03:43:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FEml56lpWq/Render', 03:43:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:11 INFO - 'HOME': '/Users/cltbld', 03:43:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:11 INFO - 'LOGNAME': 'cltbld', 03:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:11 INFO - 'MOZ_NO_REMOTE': '1', 03:43:11 INFO - 'NO_EM_RESTART': '1', 03:43:11 INFO - 'PAGER': '/bin/cat', 03:43:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:11 INFO - 'PWD': '/builds/slave/test', 03:43:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:11 INFO - 'SHELL': '/bin/bash', 03:43:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8lL0Qgwnu/Listeners', 03:43:11 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:43:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:11 INFO - 'USER': 'cltbld', 03:43:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:11 INFO - 'XPC_FLAGS': '0x0', 03:43:11 INFO - 'XPC_SERVICE_NAME': '0', 03:43:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:43:12 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-1LY0d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:43:12 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-x00TH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:12 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-HPVo_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:12 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-WMIjlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:12 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-QX89_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:12 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-7qAPFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:43:12 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-I9kVKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:43:12 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-aiCDIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:43:12 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-eUMiow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:43:13 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-nERGdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:43:13 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-8YV49p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:43:13 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-e4qsw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:43:13 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-SkWs51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:43:13 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-eY23dY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:13 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-4_Stqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:43:13 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ED6Z_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:43:13 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-3_XTqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:43:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:43:13 INFO - Running setup.py install for manifestparser 03:43:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:43:14 INFO - Running setup.py install for mozcrash 03:43:14 INFO - Running setup.py install for mozdebug 03:43:14 INFO - Running setup.py install for mozdevice 03:43:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:43:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:43:14 INFO - Running setup.py install for mozfile 03:43:14 INFO - Running setup.py install for mozhttpd 03:43:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:43:14 INFO - Running setup.py install for mozinfo 03:43:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:43:14 INFO - Running setup.py install for mozInstall 03:43:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:43:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:43:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:43:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:43:15 INFO - Running setup.py install for mozleak 03:43:15 INFO - Running setup.py install for mozlog 03:43:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:43:15 INFO - Running setup.py install for moznetwork 03:43:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:43:15 INFO - Running setup.py install for mozprocess 03:43:15 INFO - Running setup.py install for mozprofile 03:43:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:43:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:43:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:43:15 INFO - Running setup.py install for mozrunner 03:43:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:43:16 INFO - Running setup.py install for mozscreenshot 03:43:16 INFO - Running setup.py install for moztest 03:43:16 INFO - Running setup.py install for mozversion 03:43:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:43:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:43:16 INFO - Cleaning up... 03:43:16 INFO - Return code: 0 03:43:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:16 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 0x10768da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10769d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0da565cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752ce00>, '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 0x107355db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107527b20>, '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.FEml56lpWq/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.H8lL0Qgwnu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:43:16 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 03:43:16 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 03:43:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FEml56lpWq/Render', 03:43:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:16 INFO - 'HOME': '/Users/cltbld', 03:43:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:16 INFO - 'LOGNAME': 'cltbld', 03:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:16 INFO - 'MOZ_NO_REMOTE': '1', 03:43:16 INFO - 'NO_EM_RESTART': '1', 03:43:16 INFO - 'PAGER': '/bin/cat', 03:43:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:16 INFO - 'PWD': '/builds/slave/test', 03:43:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:16 INFO - 'SHELL': '/bin/bash', 03:43:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8lL0Qgwnu/Listeners', 03:43:16 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:43:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:16 INFO - 'USER': 'cltbld', 03:43:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:16 INFO - 'XPC_FLAGS': '0x0', 03:43:16 INFO - 'XPC_SERVICE_NAME': '0', 03:43:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:43:16 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-4_XRxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:43:16 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)) 03:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:43:16 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-dqLGyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:16 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)) 03:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:16 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ojdGmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:17 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)) 03:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:17 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-MdF0C9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:17 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)) 03:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:17 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-KjMJ0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:17 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)) 03:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:17 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-GjOz6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:43:17 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)) 03:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:43:17 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-MYkmJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:43:17 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)) 03:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:43:17 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-FVS6iY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:43:17 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)) 03:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:43:17 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-rFDGkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:43:17 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)) 03:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:43:17 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-NglnYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 03:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:43:17 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-8klIFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:43:17 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)) 03:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:43:17 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-4omnrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 03:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:43:18 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-rAvmjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:43:18 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)) 03:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:43:18 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-6ERNo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 03:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:18 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-fAeUyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:18 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)) 03:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:43:18 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-DcsD6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:43:18 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)) 03:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:43:18 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Sv2aMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:43:18 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)) 03:43:18 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)) 03:43:18 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)) 03:43:18 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)) 03:43:18 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)) 03:43:18 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)) 03:43:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:20 INFO - Downloading blessings-1.6.tar.gz 03:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:43:21 INFO - Installing collected packages: blessings 03:43:21 INFO - Running setup.py install for blessings 03:43:21 INFO - Successfully installed blessings 03:43:21 INFO - Cleaning up... 03:43:21 INFO - Return code: 0 03:43:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:43:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:43:21 INFO - Reading from file tmpfile_stdout 03:43:21 INFO - Current package versions: 03:43:21 INFO - blessings == 1.6 03:43:21 INFO - blobuploader == 1.2.4 03:43:21 INFO - docopt == 0.6.1 03:43:21 INFO - manifestparser == 1.1 03:43:21 INFO - mozInstall == 1.12 03:43:21 INFO - mozcrash == 0.17 03:43:21 INFO - mozdebug == 0.1 03:43:21 INFO - mozdevice == 0.48 03:43:21 INFO - mozfile == 1.2 03:43:21 INFO - mozhttpd == 0.7 03:43:21 INFO - mozinfo == 0.9 03:43:21 INFO - mozleak == 0.1 03:43:21 INFO - mozlog == 3.1 03:43:21 INFO - moznetwork == 0.27 03:43:21 INFO - mozprocess == 0.22 03:43:21 INFO - mozprofile == 0.28 03:43:21 INFO - mozrunner == 6.11 03:43:21 INFO - mozscreenshot == 0.1 03:43:21 INFO - mozsystemmonitor == 0.0 03:43:21 INFO - moztest == 0.7 03:43:21 INFO - mozversion == 1.4 03:43:21 INFO - psutil == 3.1.1 03:43:21 INFO - requests == 1.2.3 03:43:21 INFO - wsgiref == 0.1.2 03:43:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:21 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 0x10768da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10769d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0da565cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752ce00>, '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 0x107355db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107527b20>, '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.FEml56lpWq/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.H8lL0Qgwnu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:43:21 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 03:43:21 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 03:43:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FEml56lpWq/Render', 03:43:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:21 INFO - 'HOME': '/Users/cltbld', 03:43:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:21 INFO - 'LOGNAME': 'cltbld', 03:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:21 INFO - 'MOZ_NO_REMOTE': '1', 03:43:21 INFO - 'NO_EM_RESTART': '1', 03:43:21 INFO - 'PAGER': '/bin/cat', 03:43:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:21 INFO - 'PWD': '/builds/slave/test', 03:43:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:21 INFO - 'SHELL': '/bin/bash', 03:43:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8lL0Qgwnu/Listeners', 03:43:21 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:43:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:21 INFO - 'USER': 'cltbld', 03:43:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:21 INFO - 'XPC_FLAGS': '0x0', 03:43:21 INFO - 'XPC_SERVICE_NAME': '0', 03:43:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:21 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)) 03:43:21 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)) 03:43:21 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)) 03:43:21 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)) 03:43:21 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)) 03:43:21 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)) 03:43:21 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)) 03:43:21 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)) 03:43:21 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)) 03:43:21 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)) 03:43:21 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)) 03:43:21 INFO - Cleaning up... 03:43:21 INFO - Return code: 0 03:43:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10768da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10769d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0da565cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752ce00>, '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 0x107355db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107527b20>, '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.FEml56lpWq/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.H8lL0Qgwnu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:43:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FEml56lpWq/Render', 03:43:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:21 INFO - 'HOME': '/Users/cltbld', 03:43:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:21 INFO - 'LOGNAME': 'cltbld', 03:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:21 INFO - 'MOZ_NO_REMOTE': '1', 03:43:21 INFO - 'NO_EM_RESTART': '1', 03:43:21 INFO - 'PAGER': '/bin/cat', 03:43:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:21 INFO - 'PWD': '/builds/slave/test', 03:43:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:21 INFO - 'SHELL': '/bin/bash', 03:43:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8lL0Qgwnu/Listeners', 03:43:21 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:43:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:21 INFO - 'USER': 'cltbld', 03:43:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:21 INFO - 'XPC_FLAGS': '0x0', 03:43:21 INFO - 'XPC_SERVICE_NAME': '0', 03:43:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:22 INFO - Downloading/unpacking jsonschema 03:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:43:24 INFO - Downloading/unpacking functools32 (from jsonschema) 03:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:24 INFO - Downloading functools32-3.2.3-2.tar.gz 03:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:43:24 INFO - warning: no files found matching '*.txt' 03:43:24 INFO - no previously-included directories found matching 'build' 03:43:24 INFO - no previously-included directories found matching 'dist' 03:43:24 INFO - no previously-included directories found matching '.git*' 03:43:24 INFO - Installing collected packages: jsonschema, functools32 03:43:25 INFO - Running setup.py install for functools32 03:43:25 INFO - warning: no files found matching '*.txt' 03:43:25 INFO - no previously-included directories found matching 'build' 03:43:25 INFO - no previously-included directories found matching 'dist' 03:43:25 INFO - no previously-included directories found matching '.git*' 03:43:25 INFO - Successfully installed jsonschema functools32 03:43:25 INFO - Cleaning up... 03:43:25 INFO - Return code: 0 03:43:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:25 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10768da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10769d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0da565cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752ce00>, '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 0x107355db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107527b20>, '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.FEml56lpWq/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.H8lL0Qgwnu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:43:25 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', 'flake8'] in /builds/slave/test/build 03:43:25 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 flake8 03:43:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FEml56lpWq/Render', 03:43:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:25 INFO - 'HOME': '/Users/cltbld', 03:43:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:25 INFO - 'LOGNAME': 'cltbld', 03:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:25 INFO - 'MOZ_NO_REMOTE': '1', 03:43:25 INFO - 'NO_EM_RESTART': '1', 03:43:25 INFO - 'PAGER': '/bin/cat', 03:43:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:25 INFO - 'PWD': '/builds/slave/test', 03:43:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:25 INFO - 'SHELL': '/bin/bash', 03:43:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8lL0Qgwnu/Listeners', 03:43:25 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:43:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:25 INFO - 'USER': 'cltbld', 03:43:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:25 INFO - 'XPC_FLAGS': '0x0', 03:43:25 INFO - 'XPC_SERVICE_NAME': '0', 03:43:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:25 INFO - Downloading/unpacking flake8 03:43:25 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 03:43:25 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 03:43:25 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 03:43:25 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 03:43:25 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 03:43:25 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 03:43:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:43:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:43:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:43:29 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 03:43:29 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 03:43:29 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 03:43:29 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 03:43:29 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 03:43:29 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 03:43:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:43:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:43:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:43:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:43:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:43:29 INFO - no previously-included directories found matching 'docs/_build' 03:43:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:43:29 INFO - Running setup.py install for pep8 03:43:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:43:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:43:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:43:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:43:29 INFO - no previously-included directories found matching 'docs/_build' 03:43:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:43:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:43:29 INFO - Cleaning up... 03:43:29 INFO - Return code: 0 03:43:29 INFO - Running post-action listener: _resource_record_post_action 03:43:29 INFO - Running post-action listener: _start_resource_monitoring 03:43:29 INFO - Starting resource monitoring. 03:43:29 INFO - ##### 03:43:29 INFO - ##### Running install step. 03:43:29 INFO - ##### 03:43:29 INFO - Running pre-action listener: _resource_record_pre_action 03:43:29 INFO - Running main action method: install 03:43:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:43:30 INFO - Reading from file tmpfile_stdout 03:43:30 INFO - Detecting whether we're running mozinstall >=1.0... 03:43:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:43:30 INFO - Reading from file tmpfile_stdout 03:43:30 INFO - Output received: 03:43:30 INFO - Usage: mozinstall [options] installer 03:43:30 INFO - Options: 03:43:30 INFO - -h, --help show this help message and exit 03:43:30 INFO - -d DEST, --destination=DEST 03:43:30 INFO - Directory to install application into. [default: 03:43:30 INFO - "/builds/slave/test"] 03:43:30 INFO - --app=APP Application being installed. [default: firefox] 03:43:30 INFO - mkdir: /builds/slave/test/build/application 03:43:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:44:04 INFO - Reading from file tmpfile_stdout 03:44:04 INFO - Output received: 03:44:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:44:04 INFO - Running post-action listener: _resource_record_post_action 03:44:04 INFO - ##### 03:44:04 INFO - ##### Running run-tests step. 03:44:04 INFO - ##### 03:44:04 INFO - Running pre-action listener: _resource_record_pre_action 03:44:04 INFO - Running main action method: run_tests 03:44:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:44:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:44:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:44:04 INFO - 2016-04-23 03:44:04.077 screenresolution[1957:16069] starting screenresolution argv=screenresolution get 03:44:04 INFO - 2016-04-23 03:44:04.079 screenresolution[1957:16069] Display 0: 1600x1200x32@60 03:44:04 INFO - 2016-04-23 03:44:04.085 screenresolution[1958:16071] starting screenresolution argv=screenresolution list 03:44:04 INFO - Available Modes on Display 0 03:44:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:44:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:44:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:44:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:44:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:44:04 INFO - Intel Iris: 03:44:04 INFO - Chipset Model: Intel Iris 03:44:04 INFO - Type: GPU 03:44:04 INFO - Bus: Built-In 03:44:04 INFO - VRAM (Dynamic, Max): 1536 MB 03:44:04 INFO - Vendor: Intel (0x8086) 03:44:04 INFO - Device ID: 0x0a2e 03:44:04 INFO - Revision ID: 0x0009 03:44:04 INFO - Displays: 03:44:04 INFO - Display: 03:44:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:44:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:44:04 INFO - Display Serial Number: 1600x1200 60 03:44:04 INFO - Main Display: Yes 03:44:04 INFO - Mirror: Off 03:44:04 INFO - Online: Yes 03:44:04 INFO - Rotation: Supported 03:44:04 INFO - Return code: 0 03:44:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:44:04 INFO - Python 2.7.3 03:44:04 INFO - Return code: 0 03:44:04 INFO - grabbing minidump binary from tooltool 03:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:04 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752ce00>, '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 0x107355db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107527b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:44:04 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 03:44:04 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 03:44:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:44:04 INFO - Return code: 0 03:44:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:44:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:44:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:44:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:44:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:44:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:44:05 INFO - Return code: 0 03:44:05 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/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--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 03:44:05 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/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0100 --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 03:44:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FEml56lpWq/Render', 03:44:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:05 INFO - 'HOME': '/Users/cltbld', 03:44:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:05 INFO - 'LOGNAME': 'cltbld', 03:44:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:05 INFO - 'MOZ_NO_REMOTE': '1', 03:44:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:05 INFO - 'NO_EM_RESTART': '1', 03:44:05 INFO - 'PAGER': '/bin/cat', 03:44:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:05 INFO - 'PWD': '/builds/slave/test', 03:44:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:05 INFO - 'SHELL': '/bin/bash', 03:44:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8lL0Qgwnu/Listeners', 03:44:05 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:44:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:05 INFO - 'USER': 'cltbld', 03:44:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:05 INFO - 'XPC_FLAGS': '0x0', 03:44:05 INFO - 'XPC_SERVICE_NAME': '0', 03:44:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:05 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/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--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 03:44:05 INFO - mozversion application_buildid: 20160423014751 03:44:05 INFO - mozversion application_changeset: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 03:44:05 INFO - mozversion application_display_name: Nightly 03:44:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:44:05 INFO - mozversion application_name: Firefox 03:44:05 INFO - mozversion application_remotingname: firefox 03:44:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:44:05 INFO - mozversion application_vendor: Mozilla 03:44:05 INFO - mozversion application_version: 48.0a1 03:44:05 INFO - mozversion platform_buildid: 20160423014751 03:44:05 INFO - mozversion platform_changeset: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 03:44:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:44:05 INFO - mozversion platform_version: 48.0a1 03:44:05 INFO - using testdate: 1461408245 03:44:05 INFO - actual date: 1461408245 03:44:05 INFO - starting webserver on 'localhost:51814' 03:44:05 INFO - SUITE-START | Running 2 tests 03:44:05 INFO - TEST-START | dromaeo_css 03:44:05 INFO - operating with platform_type : mac_ 03:44:05 INFO - Initialising browser for dromaeo_css test... 03:44:05 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpXPdVvh/profile http://localhost:51814/getInfo.html) 03:44:07 INFO - PROCESS | 1976 | __metrics Screen width/height:1600/1200 03:44:07 INFO - PROCESS | 1976 | colorDepth:24 03:44:07 INFO - PROCESS | 1976 | Browser inner width/height: 1024/689 03:44:07 INFO - PROCESS | 1976 | __metrics 03:44:08 INFO - PROCESS | 1976 | 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" 03:44:08 ERROR - PROCESS | 1976 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:44:08 INFO - TEST-INFO | 1976: exit 0 03:44:08 INFO - Browser initialized. 03:44:08 INFO - Running cycle 1/1 for dromaeo_css test... 03:44:08 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpXPdVvh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:20 INFO - PROCESS | 1978 | RSS: Main: 239128576 03:44:20 INFO - PROCESS | 1978 | 03:45:11 INFO - PROCESS | 1978 | 1461408311845 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] 03:47:21 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:51814/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51814/tests/dromaeo/cssquery-ext.html) 03:47:23 INFO - PROCESS | 1978 | RSS: Main: 446287872 03:47:23 INFO - PROCESS | 1978 | 03:50:26 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:51814/tests/dromaeo/cssquery-ext.html (next: http://localhost:51814/tests/dromaeo/cssquery-jquery.html) 03:50:27 INFO - PROCESS | 1978 | RSS: Main: 381526016 03:50:27 INFO - PROCESS | 1978 | 03:53:29 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:51814/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51814/tests/dromaeo/cssquery-mootools.html) 03:53:30 INFO - PROCESS | 1978 | RSS: Main: 377987072 03:53:30 INFO - PROCESS | 1978 | 03:56:32 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:51814/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51814/tests/dromaeo/cssquery-prototype.html) 03:56:33 INFO - PROCESS | 1978 | RSS: Main: 375091200 03:56:33 INFO - PROCESS | 1978 | 03:59:36 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:51814/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51814/tests/dromaeo/cssquery-yui.html) 03:59:37 INFO - PROCESS | 1978 | RSS: Main: 345649152 03:59:37 INFO - PROCESS | 1978 | 04:02:40 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:51814/tests/dromaeo/cssquery-yui.html (next: http://localhost:51814/tests/dromaeo/cssquery-dojo.html) 04:02:40 INFO - PROCESS | 1978 | RSS: Main: 395964416 04:02:40 INFO - PROCESS | 1978 | 04:02:40 INFO - PROCESS | 1978 | __start_tp_report 04:02:40 INFO - PROCESS | 1978 | _x_x_mozilla_page_load 04:02:40 INFO - PROCESS | 1978 | _x_x_mozilla_page_load_details 04:02:40 INFO - PROCESS | 1978 | |i|pagename|runs| 04:02:40 INFO - PROCESS | 1978 | |0;dojo.html;2818.464491746568;3418.3676019936315;3428.7942723436595;3446.327966046622;3523.9471407928886;5507.9449205508035;5612.69130197839;5637.830865074049;5642.238297829792;5649.23735295735;5321.175217841241;5638.633488823224;5707.058335374669;5742.885142297151;5755.39568345324;5098.541131298182;5108.182690769478;5138.665986710852;5140.485951404867;5212.791488340462;5218.269442278084;5242.18746094356;5254.054270231357;5254.710990895499;5303.787848486056;5072.1630930896545;5135.820246291362;5189.117849965515;5191.610629202806;5197.5322220999915;5133.204353325241;5185.6888586684545;5187.118189907725;5194.584433245369;5254.500822421864;5131.692098474066;5147.279380886679;5173.3533308336455;5197.0385478686185;5224.190250511177;5425.02349577076;5534.391216966131;5537.8061767837935;5540.418256083093;5544.417836127229;6124.3809352984035;6204.81385558434;6233.065040243954;6233.563650544464;6240.344763799781;6227.501799856046;6278.811635650938;6311.305756366796;6312.621242725451;6317.873642527124;5602.775888964477;5756.683382413966;5757.337906140806;5762.827115186551;5762.97118514409;6236.314005459396;6311.495080393557;6330.968345158245;6339.492840572743;6358.650274234869;4976.950230497649;6095.299040610298;6098.939010609926;6101.176341193971;6109.5112391008615;6120.234970628671;6164.198654174928;6260.686965651699;6269;6284.402981716729;6100.157317757059;6106.673025714474;6132.356102609251;6135;6159.23009623797;6230.532710046765;6233.844153896098;6240.344763799826;6245.156903817927;6255.061740738925;4103.4460347853255;4889.997550502138;4906.803727850917;4955.776990035457;4962.330085438492;4302.26861433557;4308.913821723548;4404.273294906305;4430.4683437987005;4437.955620443754;5622.887542249132;5642.379338272786;5647.124695672177;5661.094224923992;5664.518515926193;6241.937580624226;6275.341089185661;6297.27581328144;6306.085617585424;6334;5524.779008839681;5571.554275658019;5601.579881508903;5606.159076138611;5615.129654903497;4454.309582014793;5345.3852806926925;5364.651297665718;5376.4085950545405;5448.237246785453;6325.335839736854;6336.778212762623;6346.30190679025;6351.936480635134;6367.490600752021;6245.156903817927;6294.464970477561;6300.401461861115;6304;6309.463695585927;6261.123442717932;6270.184875966095;6348.174737284124;6348.523860710373;6354.142190804182;6062.393760623902;6075.969620151871;6079.969600152148;6089.786857459968;6095.207623008981;5063.215201643751;6117.632942023492;6137.844210862897;6144.556029333193;6302.212223472066;5223.69407648088;6113.327533971348;6124.54065945047;6139.508839292936;6141.631502109709;5789.739461724317;6047.576669633084;6061.696915154313;6065.7876974307455;6071.696415179135;5760.1935728998815;5838.970805145947;5852.795152169653;5868.765249389977;5876.059830427112;5191.8318378364565;5311.973440132774;5785.3636100028125;5828.94171058301;5836.883262334644;5875.441833025856;5916.733746981482;5949.672767997802;5981.431763982415;5981.910271346021 04:02:40 INFO - PROCESS | 1978 | |1;ext.html;521.0932976620682;529.9576033917285;531.0467710459725;531.3650188025312;547.8219578636944;38117.23765524688;39370.60629393705;39580;39583.20833583327;39712.014399280066;41516.16967660645;42177.945551361154;42332.153356932846;42365.72902812921;42444;8628.137186281385;8862.556872156398;9589.37669051513;9836.163926066292;9842.114209721123;9453.905460945405;12035.097367697457;12050.758984820299;12068.879311206863;12089.516419343216;10908;11600;11721.882781172164;11724.706882327968;11798.997085247764;8755.299576033902;11656.941715291412;11677.474513646906;11946;11970.461329240205;11639.534418623245;11795.528178872835;11811.173217874752;11820.881791182064;11823.527058917633;40590;40840;40843.59156408428;40894;40998.59001409978;3231.062991732395;3242;3294.2423242654086;3369.5956485221686;3579.699530888152;24095.397615059588;25891.482170356674;29223.56164657532;29251.56122658162;29909.6540655671;2705.9323516912036;2706.431649353638;2710.7966902482394;2711.2137480130737;2888.292368369742;420495;511966;512179;512571.9999999963;513569;61670;62032.37967620356;62509;62646.68676656587;62705.05942410776;65789.34210657928;68510;70467.64766176137;70491;70522.2947770526;16737.748933766004;16911.900726452743;16975.368817833256;16978.745318820227;17011.744823827652;11892.167548271538;12144.33206173669;12909.677258068436;13247.00647451445;13263.801042984363;19213.423597292105;19266.518337041685;19340.4197874064;19395.224191032485;19410.320638777575;6795;8008.919910800934;8223.301019413417;8274.462159959583;8303.626336814857;799.8240387114826;983.7079604521448;1076.671615157369;1147.8794726553758;1173.501261963662;29221.853890730836;29276;29446.705532944397;30162.24594385114;30174.24564385864;1024.1857723110145;1094.7427354571669;1210.3827048205303;1220.45079714129;1224.6203676860202;15244.847551524565;15377.9231103846;15412.306446209723;15434.131661941681;15542;651153;663026;663232;663867;664227;59445;61702;61727.38272617216;61868.69065654733;61933.38066619276;1197.8261303922031;1303.4199781097511;1327.9601611951657;1414.1515090945556;1574.661447788708;22407.551848962605;29962;30484.683755257905;30954;32597.837010814794;53581.73209133929;54006;54199.64500887509;54357.45642543524;54399;494428;498881;499083.5412406523;499239;499883;21461.46346341354;23703.05187792538;24252.393690157885;26931.596026060015;27110.1866943992;43492.56507434885;45149.87125321893;45184.54815451804;45669;46254.30618540792;36855;36865.63134368622;36919.630803691616;37788.81105594454;37838.62161378351;32660.673393266712;36454.4531832028;36634.63365366312;36832.26335473329;37657;34360.82819585886;36597.634023659426;37763;37776.6778162763;37848.62151378451;31432.685673142976;32233.51649725303;32255.35489290248;32326;32357.838210809736;23579.521339012612;24076.277711668678;24179.680470296506;24539.754602453748;24554.50890982206 04:02:40 INFO - PROCESS | 1978 | |2;jquery.html;398.2135282816438;400.119736579525;402.7221217360023;404.08273219791096;414.31844615607326;14959.775603365959;19904.90047549762;20881.582368352643;20946.685799713;21539.67690484644;16220.513384598451;18407;20258.59482810343;20644.89677551614;21140.365789026353;5975.253093363319;6150.6924653767355;6197.194364732579;6206.875862482748;6207.81376558704;6029.155918171459;6084.756609735606;6086.665233412161;6102.359252278514;6168.352323006087;5881.647101173922;6094.695265236743;6103.298120716108;6105.908411373833;6127.387261273881;5785.768569257225;6037.7584896604085;6152.630842149485;6152.630842149485;6158.8768224635705;5693.601447898649;5915.1718759373725;5925.170476133345;5931.73307201177;5940.198073260098;25961.221163364942;26214;26291.34271643205;26668.93324267027;26752.73247267522;2065.8037486438916;2081.0427203486415;2084.5414008918015;2092.1526781653456;2124.9043793029196;9657.806843863083;9972.90027099727;10099.747506312327;15023.549293521211;15173.696526069416;1706.598949246926;1722.5865792209904;1766.1081154017268;1784.9107544622716;1798.0560205891882;99077.50461247719;115306.11734706616;118911;122975.54048918972;128917;9585.376950498196;11444.713882152846;11712.70718232051;11952.880471195176;12035;15384.15387153695;15451.922740386452;15458;15479.922600386926;15484.993475424286;6857.417119544894;7552.546847189186;7968.521888686697;8721.825563488695;8890.288776897833;7020.473464490184;7194.820129496699;8661.220490155916;8727.65089396417;8780.956095219612;4605.171069207575;4658.8120029392285;4694.319323698045;4743.407074115736;4760.880977975578;1914.9425517234506;1975.8221760041379;1980.8415326773822;1992.1035534009463;2020.5251765835017;852.7271273192642;921.1019256225127;990.8761404824397;996.4619105682995;1029.7991891581219;20981.265655701976;21542.784572154076;21689.981983240894;21755.782442175376;22612.434689132904;914.401067300919;922.9123233292827;957.4255446732044;1008.7377281906611;1032.2052019944751;10972.615958441416;11318.547258109584;11345.09239260857;11377.943110284561;11408.429578521042;577264;583015;588604;603151;606279;73678;126166;129093.35453322862;135267.32366338104;138497.61502384848;1039.2673165418362;1044.9111825494917;1069.1820757120809;1081.848541204232;1087.7117563845586;18647.44057678272;18793.34223302178;18829.717554236973;18856.52858678544;18870.150843211813;50588.988220234656;51309.23036154536;51935.48064519458;51984.74007629938;52319.47680523146;72465.27534724586;74557.6272118636;74740.50518989698;74994.25005749872;78240.43519129472;6805.421539169226;7737;7967.163447838126;8140.959295203486;8366.163383661586;10502.632407865687;11889.702757430787;12267.938660306641;12322.39808824847;12368.505259789868;10756.031957123896;10766.407847568458;10801.189910756882;10821.296615720268;10912.563497460013;10523.263371563917;10554.788904222027;10691.30506517074;10790.622328218475;10946.671599852018;10952.452377381258;11090.168237382068;11284.661460156209;11403.828942566033;11477.139214558774;8028.1169071403265;8071.919280807351;8171.918280817115;8180.345572354317;8269.83460330802;8108.3513318933165;9945.80650321966;10831.241813073324;11068.5572577096;11179.888201117885 04:02:40 INFO - PROCESS | 1978 | |3;mootools.html;1358.30726329572;1446.9437310763142;1463.8828893688503;1779.6440711857624;1988.0556735550615;7820.257075577818;8517.616707248173;8811.295096392289;8818.779530511725;8830.426022308562;8428.873566896502;8675.869861952076;8680.826383472328;8688.304935605152;8705.042445331008;2434.9878250608767;2464.223769512607;2465.494573612405;2468.814838887082;2470.3824043989002;2402.5555272274596;2464.5933420985516;2464.8890799913956;2469.938251543708;2474.9010039598393;2077.366403247009;2423.624338227569;2440.8413453125577;2455.165243817102;2462.310553045141;2367.1005018093188;2392.712874455059;2396.628522579003;2402.2072716003763;2414.6619473273754;2364.775346342095;2391.1033362489065;2398.5322862041908;2399.568077746005;2401.3156250468533;8507.447015943944;8711.08533603975;8727.956360218159;8797.736067917973;8823.823523529558;5159.819406320761;5355.571554275649;5362.356517217959;5370.409254981949;5378.354597448331;3485.7734247273847;3494.9650503494895;3570.8571657133684;3592.1199306170156;3597.4963505109304;1017.115109854424;1028.239103063735;1028.8816786069624;1037.2065369991963;1042.9947850260776;11277.266977646426;11601.825972610417;11616.825747613793;11626.941865290704;11670.883291167149;3814.9127498662747;4249.851255206115;4603.562661547147;4697.037107393045;4697.95302046982;9071.047540008203;9077.818443631091;9078.682246121487;9094.045125261884;9109.18017378439;5219.791208351623;5242.97378513105;5268.209768534751;5269.104252277122;5281.762320695578;4352.064306174188;4537.842850073276;4744.786484608201;4874.317595536628;4924.4583095859425;3736.9065773355883;3780.6597406233573;3852.24881148179;3853.499045124116;3886.7862267575556;1186.5965571705663;1190.7558950415316;1190.9047276217882;1196.4137572589368;1204.5121725701106;677.9762708305186;826.3760860550366;900.7027680865299;966.8066386722684;984.3896783993827;5711.628744131618;5872.207252021008;5929.673867937218;5933.021051526536;5934.1692163097205;479.92321228603254;487.64645631917284;492.36730800920645;496.5371756089835;583.5818959927417;3746.812659367021;3979.945314491662;4041.939370909439;4081.673466122703;4083.673306135502;9976.80046399068;10749.193810464247;10854.131669466424;10857.67426977192;10882.727931801768;10454.477276136315;10607.840882386616;10649.254552181428;10694.893051069545;10801.297915635458;8108.9594552026865;8124.5937703114605;8178.5092894426525;8218.342532597379;8226.629801659059;5678.3753787084215;5752.424757524214;5839.854003649943;5905.379935106752;5910.881782364415;9672.93597704238;9856.063673950963;10004.199664027006;10005.449700266556;10008.249381296286;9833.852492212765;9850.113489785954;10077.445740484343;10190.98090190975;10256.743581410525;6885.8967115492305;6911.205211400753;6956.652167391509;6972.372486476242;6984.371406573433;8052.194780521901;8064.758057258292;8117.1071182168735;8157.918420815953;8165.265126138676;7374.926250737424;7418.703251870081;7458.5151965122095;7502.699892004477;7577.431692622965;7274.236205198589;7280;7364.116306043309;7390.96304518474;7455.7017719290625;6696.397324240842;7007.983842342934;7008.474364422586;7010.964945175446;7017.754378596725;3783.0353259918543;4803.423589169322;4864.562189402971;4872.14737420957;5102.158143906214;4913.70517768935;5013.097642424399;5035.748212589283;5038.571721403721;5042 04:02:40 INFO - PROCESS | 1978 | |4;prototype.html;307.42511503488464;313.95290706394036;324.6364072239092;327.0466589890468;327.4662300450266;4909.459959404468;5856.414358564147;5886.205362276091;5927.103326935382;5997.37027612101;5610.607257491977;5642.858928526789;5847.619904706191;5857.26784151981;5945.346011938684;4394.6703997200175;4488.955110448903;4489.820407183709;4508.797104130305;4509.639228861692;4490.777065352655;4502.189605870958;4507.256302710065;4509.25597276449;4520.932186017212;3514.787398347579;4473.306637471181;4474.172278128541;4480.148771733377;4495.43807024122;4423.646108311327;4440.667799660089;4460.933086003713;4480.686351955364;4514.909701805946;3594.658507441789;3920.5491368492703;3924.274009308287;3927.9214415711526;3928.7839168845703;5518.902816929582;5648.830535083954;5674.716264186774;5674.9716251418895;5698.487136157766;4088.3663032229756;4408.118376324748;4920.852374428773;5044.117279476077;5145.30538377318;6022;6218.160548325964;6231.781887633956;6254.903822607793;6292.62244265341;3569.6787289144104;3910.667593254577;4228.894277643053;4288.871333859958;4299.441072660566;5351.464853514656;6526.118973938505;6588.538802283842;6608.257573107155;6619.93380066198;3774.6036666150208;4271.782541975522;4377.321515165155;4378.56214378566;4403.163398954189;4044.8179831907637;4304.461942257218;4321.935170972438;4333.826646934087;4337.392765012901;4819.566239038503;5014.84955451337;5015;5076.6192535559985;5089.982003599295;5919.3192782829665;6308.684565771693;6317.652529110851;6320.5349913533755;6330.335314791972;1297.6172029251393;1329.1028555724847;1438.6475313548037;1466.5746933389412;1501.9549413517611;947.6067432015636;957.2533423929347;972.7568107973007;973.0658567775015;974.152487336008;4767.73777442244;5747.298769578291;5751.942480575224;5758.2514273144225;5801.50687191585;5620.932022915633;6113;6418.550701450854;6421.550491465552;6424.49024479247;4764.475907650225;5425.430329815313;5426.810061647823;5727.942720572741;5760.193572899798;3355.2282974915906;3375.4093033719;3406.386850366908;3408.965910340865;3424.931501369959;6468;6659;6672;6685.732570697215;6710.429613482908;6526.151600292027;6545.14913061299;6553.57401768893;6568.376004279586;6572.80281591553;6508.893488106938;6633.502487313374;6652.268250492442;6662.467002639777;6666.933330666729;6294.4964402846745;6339.207599050119;6383.680815959091;6384.840378990562;6394.328595497592;5315.282436870973;6157.9384206157365;6275.152854364785;6304.460788232649;6304.7162877671535;5404.8919971404985;5984.371640977809;6332.30344662096;6634.919524492306;6708.6981085850275;4205.411242426124;4215.473065866767;4222.239996800606;4237.982884107853;4239.639630631431;5235.476452354734;6120;6245.843853903507;6370.140031095742;6406.647634380154;4894.681845680019;5663.536361682682;6069.696515174312;6183.721732522137;6357.029320910533;6261.7182226799;6275.6548389839;6307.905381419374;6314.6842657866;6318.526110541819;4890.779914903909;5124.976264004255;5273.525382715574;6059.363766804422;6237.345078766664;6172.351903050115;6239.313675495601;6255.155554000152;6312.747490100528;6316.652584107918;5776.971115144397;6167.889779839672;6170.500947116425;6181.783637572664;6203.627782333075 04:02:40 INFO - PROCESS | 1978 | |5;yui.html;652.2596852572331;729.0413106764607;734.6987735028639;741.758928348287;743.4613464361804;14893.255337233135;15031.624209394771;15306.158161301124;15328.770068448983;15347.155906425129;13948.02363834532;14056.15663060217;14156.433742650283;14172.007959442843;14181.361838717257;735.7020406735281;756.6065645864174;920.4201353147524;924.4499522783966;925.0703043441366;898.3890954151175;944.5607792376578;947.2469386837481;947.9383840050375;948.3503799897059;985.1527686189871;994.6717583197563;996.0885789502596;997.5560875410446;999.1307562420668;765.4144579396766;960.9087136722001;986.9851952220722;988.4464699768153;989.1098011789376;734.1887214627866;736.054170391045;737.6090671943824;738.0774032459426;743.8103283662685;15311;15372;15387.923060384739;15391.153486558234;15396.230188490643;12153.756924861542;12290.207083897149;12334.75330493394;12452.439640216122;12481.313527756061;10142.645007424704;10163.949180254125;10193.184545236363;10580.994805493467;10662.946685266601;4029.979850100731;4105.835766569364;4133.111381053088;4210.45264115666;4308;82418.17581824165;82716;82797.58601207015;84053.57973210094;84623.15376846214;9198.816023679488;9581.712548623413;9676.70969870905;9727.221822254203;10008.949955250177;21638.675419868716;21705.67441488379;21708.674369884466;21742;21748.13007479683;7420.851582968418;7474.3273105419685;7536.208698086732;7587.810304742426;7616.8476630467085;4074.6943979201087;4143.150654115899;4150.236985701204;4151.875443736692;4430.712003719748;3627.6372362763514;3668.761530500509;3668.853245870135;3701.7038636908983;3704.481372607837;658.7957733102753;659.8548319369827;665.9467242620578;666.6400143922325;668.5554106519207;479.8296604705349;501.40522794538117;505.184127633876;580.523970344322;593.6289818863211;7574.5076570022775;7813.453058285979;8032.1164671886045;8069.0317161939765;8094.15011423792;543.7575140803245;558.4917724870348;567.7615401531367;598.317917573966;623.4420193926501;3840.7695538267794;3841.4814000109627;3888.4556162137324;3918.1967696622123;3922.2351641429645;81712;81871.18128818755;82728.58635706783;83134.75297870536;85952.57023714966;59297.40702592919;74887.62556187184;75789.24210757822;77976.22023779803;78873.4225315502;67014.32985670178;69419.30580694128;69599.65200174067;69901;70080;7503.399728021636;7568.880713400256;7676.577788221478;7742.883856742041;7756.1468238494845;31736;43365;44470;44896.77551612352;45025;59581;60285.69857150862;63015;64409.67795160994;64435.03347449698;9710.689056977217;9912.702618921443;10019.649312274036;10142.391456512632;10188.592456301962;10365.637202698172;10636.468176591294;10741.140708743438;10936.343819370863;11299.152563557602;8070.757877263692;10316;11634;11731.589394371156;11974.042076634023;11102.111831053659;11165.38590377537;11181.273217240854;11873.940630296793;12038.458269378074;10823.803990604361;11111.11111111093;11348.886511135113;11382.601608943647;11395.544178232778;9518.61925522999;9637.37357071788;9642.614295428104;9966.900330996597;10065.647702330383;8380.371472139492;9098.999110098017;9811.901880981384;9820.45987470696;9928.021593522059 04:02:40 INFO - PROCESS | 1978 | __end_tp_report 04:02:40 INFO - PROCESS | 1978 | __start_cc_report 04:02:40 INFO - PROCESS | 1978 | _x_x_mozilla_cycle_collect,2114 04:02:40 INFO - PROCESS | 1978 | __end_cc_report 04:02:40 INFO - PROCESS | 1978 | __startTimestamp1461409360259__endTimestamp 04:02:40 INFO - PROCESS | 1978 | 04:02:40 INFO - PROCESS | 1978 | ------- Summary: start ------- 04:02:40 INFO - PROCESS | 1978 | Number of tests: 6 04:02:40 INFO - PROCESS | 1978 | 04:02:40 INFO - PROCESS | 1978 | [#0] dojo.html Cycles:165 Average:5672.20 Median:5789.74 stddev:667.26 (11.5%) stddev-sans-first:630.64 04:02:40 INFO - PROCESS | 1978 | Values: 2818.5 3418.4 3428.8 3446.3 3523.9 5507.9 5612.7 5637.8 5642.2 5649.2 5321.2 5638.6 5707.1 5742.9 5755.4 5098.5 5108.2 5138.7 5140.5 5212.8 5218.3 5242.2 5254.1 5254.7 5303.8 5072.2 5135.8 5189.1 5191.6 5197.5 5133.2 5185.7 5187.1 5194.6 5254.5 5131.7 5147.3 5173.4 5197.0 5224.2 5425.0 5534.4 5537.8 5540.4 5544.4 6124.4 6204.8 6233.1 6233.6 6240.3 6227.5 6278.8 6311.3 6312.6 6317.9 5602.8 5756.7 5757.3 5762.8 5763.0 6236.3 6311.5 6331.0 6339.5 6358.7 4977.0 6095.3 6098.9 6101.2 6109.5 6120.2 6164.2 6260.7 6269.0 6284.4 6100.2 6106.7 6132.4 6135.0 6159.2 6230.5 6233.8 6240.3 6245.2 6255.1 4103.4 4890.0 4906.8 4955.8 4962.3 4302.3 4308.9 4404.3 4430.5 4438.0 5622.9 5642.4 5647.1 5661.1 5664.5 6241.9 6275.3 6297.3 6306.1 6334.0 5524.8 5571.6 5601.6 5606.2 5615.1 4454.3 5345.4 5364.7 5376.4 5448.2 6325.3 6336.8 6346.3 6351.9 6367.5 6245.2 6294.5 6300.4 6304.0 6309.5 6261.1 6270.2 6348.2 6348.5 6354.1 6062.4 6076.0 6080.0 6089.8 6095.2 5063.2 6117.6 6137.8 6144.6 6302.2 5223.7 6113.3 6124.5 6139.5 6141.6 5789.7 6047.6 6061.7 6065.8 6071.7 5760.2 5839.0 5852.8 5868.8 5876.1 5191.8 5312.0 5785.4 5828.9 5836.9 5875.4 5916.7 5949.7 5981.4 5981.9 04:02:40 INFO - PROCESS | 1978 | 04:02:40 INFO - PROCESS | 1978 | [#1] ext.html Cycles:180 Average:68987.12 Median:18865.21 stddev:148790.39 (788.7%) stddev-sans-first:149118.99 04:02:40 INFO - PROCESS | 1978 | Values: 521.1 530.0 531.0 531.4 547.8 38117.2 39370.6 39580.0 39583.2 39712.0 41516.2 42177.9 42332.2 42365.7 42444.0 8628.1 8862.6 9589.4 9836.2 9842.1 9453.9 12035.1 12050.8 12068.9 12089.5 10908.0 11600.0 11721.9 11724.7 11799.0 8755.3 11656.9 11677.5 11946.0 11970.5 11639.5 11795.5 11811.2 11820.9 11823.5 40590.0 40840.0 40843.6 40894.0 40998.6 3231.1 3242.0 3294.2 3369.6 3579.7 24095.4 25891.5 29223.6 29251.6 29909.7 2705.9 2706.4 2710.8 2711.2 2888.3 420495.0 511966.0 512179.0 512572.0 513569.0 61670.0 62032.4 62509.0 62646.7 62705.1 65789.3 68510.0 70467.6 70491.0 70522.3 16737.7 16911.9 16975.4 16978.7 17011.7 11892.2 12144.3 12909.7 13247.0 13263.8 19213.4 19266.5 19340.4 19395.2 19410.3 6795.0 8008.9 8223.3 8274.5 8303.6 799.8 983.7 1076.7 1147.9 1173.5 29221.9 29276.0 29446.7 30162.2 30174.2 1024.2 1094.7 1210.4 1220.5 1224.6 15244.8 15377.9 15412.3 15434.1 15542.0 651153.0 663026.0 663232.0 663867.0 664227.0 59445.0 61702.0 61727.4 61868.7 61933.4 1197.8 1303.4 1328.0 1414.2 1574.7 22407.6 29962.0 30484.7 30954.0 32597.8 53581.7 54006.0 54199.6 54357.5 54399.0 494428.0 498881.0 499083.5 499239.0 499883.0 21461.5 23703.1 24252.4 26931.6 27110.2 43492.6 45149.9 45184.5 45669.0 46254.3 36855.0 36865.6 36919.6 37788.8 37838.6 32660.7 36454.5 36634.6 36832.3 37657.0 34360.8 36597.6 37763.0 37776.7 37848.6 31432.7 32233.5 32255.4 32326.0 32357.8 23579.5 24076.3 24179.7 24539.8 24554.5 04:02:40 INFO - PROCESS | 1978 | 04:02:40 INFO - PROCESS | 1978 | [#2] jquery.html Cycles:180 Average:34523.22 Median:24286.83 stddev:98663.54 (406.2%) stddev-sans-first:98907.04 04:02:40 INFO - PROCESS | 1978 | Values: 398.2 400.1 402.7 404.1 414.3 14959.8 19904.9 20881.6 20946.7 21539.7 16220.5 18407.0 20258.6 20644.9 21140.4 5975.3 6150.7 6197.2 6206.9 6207.8 6029.2 6084.8 6086.7 6102.4 6168.4 5881.6 6094.7 6103.3 6105.9 6127.4 5785.8 6037.8 6152.6 6152.6 6158.9 5693.6 5915.2 5925.2 5931.7 5940.2 25961.2 26214.0 26291.3 26668.9 26752.7 2065.8 2081.0 2084.5 2092.2 2124.9 9657.8 9972.9 10099.7 15023.5 15173.7 1706.6 1722.6 1766.1 1784.9 1798.1 99077.5 115306.1 118911.0 122975.5 128917.0 9585.4 11444.7 11712.7 11952.9 12035.0 15384.2 15451.9 15458.0 15479.9 15485.0 6857.4 7552.5 7968.5 8721.8 8890.3 7020.5 7194.8 8661.2 8727.7 8781.0 4605.2 4658.8 4694.3 4743.4 4760.9 1914.9 1975.8 1980.8 1992.1 2020.5 852.7 921.1 990.9 996.5 1029.8 20981.3 21542.8 21690.0 21755.8 22612.4 914.4 922.9 957.4 1008.7 1032.2 10972.6 11318.5 11345.1 11377.9 11408.4 577264.0 583015.0 588604.0 603151.0 606279.0 73678.0 126166.0 129093.4 135267.3 138497.6 1039.3 1044.9 1069.2 1081.8 1087.7 18647.4 18793.3 18829.7 18856.5 18870.2 50589.0 51309.2 51935.5 51984.7 52319.5 72465.3 74557.6 74740.5 74994.3 78240.4 6805.4 7737.0 7967.2 8141.0 8366.2 10502.6 11889.7 12267.9 12322.4 12368.5 10756.0 10766.4 10801.2 10821.3 10912.6 10523.3 10554.8 10691.3 10790.6 10946.7 10952.5 11090.2 11284.7 11403.8 11477.1 8028.1 8071.9 8171.9 8180.3 8269.8 8108.4 9945.8 10831.2 11068.6 11179.9 04:02:40 INFO - PROCESS | 1978 | 04:02:40 INFO - PROCESS | 1978 | [#3] mootools.html Cycles:180 Average:5625.39 Median:2703.04 stddev:3160.80 (116.9%) stddev-sans-first:3153.40 04:02:40 INFO - PROCESS | 1978 | Values: 1358.3 1446.9 1463.9 1779.6 1988.1 7820.3 8517.6 8811.3 8818.8 8830.4 8428.9 8675.9 8680.8 8688.3 8705.0 2435.0 2464.2 2465.5 2468.8 2470.4 2402.6 2464.6 2464.9 2469.9 2474.9 2077.4 2423.6 2440.8 2455.2 2462.3 2367.1 2392.7 2396.6 2402.2 2414.7 2364.8 2391.1 2398.5 2399.6 2401.3 8507.4 8711.1 8728.0 8797.7 8823.8 5159.8 5355.6 5362.4 5370.4 5378.4 3485.8 3495.0 3570.9 3592.1 3597.5 1017.1 1028.2 1028.9 1037.2 1043.0 11277.3 11601.8 11616.8 11626.9 11670.9 3814.9 4249.9 4603.6 4697.0 4698.0 9071.0 9077.8 9078.7 9094.0 9109.2 5219.8 5243.0 5268.2 5269.1 5281.8 4352.1 4537.8 4744.8 4874.3 4924.5 3736.9 3780.7 3852.2 3853.5 3886.8 1186.6 1190.8 1190.9 1196.4 1204.5 678.0 826.4 900.7 966.8 984.4 5711.6 5872.2 5929.7 5933.0 5934.2 479.9 487.6 492.4 496.5 583.6 3746.8 3979.9 4041.9 4081.7 4083.7 9976.8 10749.2 10854.1 10857.7 10882.7 10454.5 10607.8 10649.3 10694.9 10801.3 8109.0 8124.6 8178.5 8218.3 8226.6 5678.4 5752.4 5839.9 5905.4 5910.9 9672.9 9856.1 10004.2 10005.4 10008.2 9833.9 9850.1 10077.4 10191.0 10256.7 6885.9 6911.2 6956.7 6972.4 6984.4 8052.2 8064.8 8117.1 8157.9 8165.3 7374.9 7418.7 7458.5 7502.7 7577.4 7274.2 7280.0 7364.1 7391.0 7455.7 6696.4 7008.0 7008.5 7011.0 7017.8 3783.0 4803.4 4864.6 4872.1 5102.2 4913.7 5013.1 5035.7 5038.6 5042.0 04:02:40 INFO - PROCESS | 1978 | 04:02:40 INFO - PROCESS | 1978 | [#4] prototype.html Cycles:180 Average:5051.37 Median:5686.73 stddev:1571.62 (27.6%) stddev-sans-first:1535.16 04:02:40 INFO - PROCESS | 1978 | Values: 307.4 314.0 324.6 327.0 327.5 4909.5 5856.4 5886.2 5927.1 5997.4 5610.6 5642.9 5847.6 5857.3 5945.3 4394.7 4489.0 4489.8 4508.8 4509.6 4490.8 4502.2 4507.3 4509.3 4520.9 3514.8 4473.3 4474.2 4480.1 4495.4 4423.6 4440.7 4460.9 4480.7 4514.9 3594.7 3920.5 3924.3 3927.9 3928.8 5518.9 5648.8 5674.7 5675.0 5698.5 4088.4 4408.1 4920.9 5044.1 5145.3 6022.0 6218.2 6231.8 6254.9 6292.6 3569.7 3910.7 4228.9 4288.9 4299.4 5351.5 6526.1 6588.5 6608.3 6619.9 3774.6 4271.8 4377.3 4378.6 4403.2 4044.8 4304.5 4321.9 4333.8 4337.4 4819.6 5014.8 5015.0 5076.6 5090.0 5919.3 6308.7 6317.7 6320.5 6330.3 1297.6 1329.1 1438.6 1466.6 1502.0 947.6 957.3 972.8 973.1 974.2 4767.7 5747.3 5751.9 5758.3 5801.5 5620.9 6113.0 6418.6 6421.6 6424.5 4764.5 5425.4 5426.8 5727.9 5760.2 3355.2 3375.4 3406.4 3409.0 3424.9 6468.0 6659.0 6672.0 6685.7 6710.4 6526.2 6545.1 6553.6 6568.4 6572.8 6508.9 6633.5 6652.3 6662.5 6666.9 6294.5 6339.2 6383.7 6384.8 6394.3 5315.3 6157.9 6275.2 6304.5 6304.7 5404.9 5984.4 6332.3 6634.9 6708.7 4205.4 4215.5 4222.2 4238.0 4239.6 5235.5 6120.0 6245.8 6370.1 6406.6 4894.7 5663.5 6069.7 6183.7 6357.0 6261.7 6275.7 6307.9 6314.7 6318.5 4890.8 5125.0 5273.5 6059.4 6237.3 6172.4 6239.3 6255.2 6312.7 6316.7 5777.0 6167.9 6170.5 6181.8 6203.6 04:02:40 INFO - PROCESS | 1978 | 04:02:40 INFO - PROCESS | 1978 | [#5] yui.html Cycles:180 Average:17534.85 Median:30454.57 stddev:24327.98 (79.9%) stddev-sans-first:24363.19 04:02:40 INFO - PROCESS | 1978 | Values: 652.3 729.0 734.7 741.8 743.5 14893.3 15031.6 15306.2 15328.8 15347.2 13948.0 14056.2 14156.4 14172.0 14181.4 735.7 756.6 920.4 924.4 925.1 898.4 944.6 947.2 947.9 948.4 985.2 994.7 996.1 997.6 999.1 765.4 960.9 987.0 988.4 989.1 734.2 736.1 737.6 738.1 743.8 15311.0 15372.0 15387.9 15391.2 15396.2 12153.8 12290.2 12334.8 12452.4 12481.3 10142.6 10163.9 10193.2 10581.0 10662.9 4030.0 4105.8 4133.1 4210.5 4308.0 82418.2 82716.0 82797.6 84053.6 84623.2 9198.8 9581.7 9676.7 9727.2 10008.9 21638.7 21705.7 21708.7 21742.0 21748.1 7420.9 7474.3 7536.2 7587.8 7616.8 4074.7 4143.2 4150.2 4151.9 4430.7 3627.6 3668.8 3668.9 3701.7 3704.5 658.8 659.9 665.9 666.6 668.6 479.8 501.4 505.2 580.5 593.6 7574.5 7813.5 8032.1 8069.0 8094.2 543.8 558.5 567.8 598.3 623.4 3840.8 3841.5 3888.5 3918.2 3922.2 81712.0 81871.2 82728.6 83134.8 85952.6 59297.4 74887.6 75789.2 77976.2 78873.4 67014.3 69419.3 69599.7 69901.0 70080.0 7503.4 7568.9 7676.6 7742.9 7756.1 31736.0 43365.0 44470.0 44896.8 45025.0 59581.0 60285.7 63015.0 64409.7 64435.0 9710.7 9912.7 10019.6 10142.4 10188.6 10365.6 10636.5 10741.1 10936.3 11299.2 8070.8 10316.0 11634.0 11731.6 11974.0 11102.1 11165.4 11181.3 11873.9 12038.5 10823.8 11111.1 11348.9 11382.6 11395.5 9518.6 9637.4 9642.6 9966.9 10065.6 8380.4 9099.0 9811.9 9820.5 9928.0 04:02:40 INFO - PROCESS | 1978 | -------- Summary: end -------- 04:02:40 INFO - PROCESS | 1978 | 04:02:40 INFO - TEST-INFO | 1978: exit 0 04:02:40 INFO - TEST-OK | dromaeo_css | took 1115118ms 04:02:40 INFO - TEST-START | kraken 04:02:40 INFO - operating with platform_type : mac_ 04:02:40 INFO - Initialising browser for kraken test... 04:02:40 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmp6mH8tH/profile http://localhost:51814/getInfo.html) 04:02:42 INFO - PROCESS | 1985 | __metrics Screen width/height:1600/1200 04:02:42 INFO - PROCESS | 1985 | colorDepth:24 04:02:42 INFO - PROCESS | 1985 | Browser inner width/height: 1024/689 04:02:42 INFO - PROCESS | 1985 | __metrics 04:02:43 INFO - PROCESS | 1985 | 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" 04:02:43 ERROR - PROCESS | 1985 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:02:43 INFO - TEST-INFO | 1985: exit 0 04:02:43 INFO - Browser initialized. 04:02:43 INFO - Running cycle 1/1 for kraken test... 04:02:43 INFO - TEST-INFO | started process 1987 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmp6mH8tH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:55 INFO - PROCESS | 1987 | RSS: Main: 239042560 04:02:55 INFO - PROCESS | 1987 | 04:02:58 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:51814/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51814/tests/kraken/driver.html?testName=audio-beat-detection) 04:02:59 INFO - PROCESS | 1987 | RSS: Main: 286773248 04:02:59 INFO - PROCESS | 1987 | 04:03:02 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:51814/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51814/tests/kraken/driver.html?testName=audio-dft) 04:03:02 INFO - PROCESS | 1987 | RSS: Main: 301232128 04:03:02 INFO - PROCESS | 1987 | 04:03:06 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:51814/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51814/tests/kraken/driver.html?testName=audio-fft) 04:03:06 INFO - PROCESS | 1987 | RSS: Main: 388976640 04:03:06 INFO - PROCESS | 1987 | 04:03:08 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:51814/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51814/tests/kraken/driver.html?testName=audio-oscillator) 04:03:09 INFO - PROCESS | 1987 | RSS: Main: 286769152 04:03:09 INFO - PROCESS | 1987 | 04:03:11 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:51814/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51814/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:03:12 INFO - PROCESS | 1987 | RSS: Main: 290959360 04:03:12 INFO - PROCESS | 1987 | 04:03:15 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:51814/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51814/tests/kraken/driver.html?testName=imaging-darkroom) 04:03:15 INFO - PROCESS | 1987 | RSS: Main: 328585216 04:03:15 INFO - PROCESS | 1987 | 04:03:18 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:51814/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51814/tests/kraken/driver.html?testName=imaging-desaturate) 04:03:19 INFO - PROCESS | 1987 | RSS: Main: 329850880 04:03:19 INFO - PROCESS | 1987 | 04:03:22 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:51814/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51814/tests/kraken/driver.html?testName=json-parse-financial) 04:03:22 INFO - PROCESS | 1987 | RSS: Main: 328691712 04:03:22 INFO - PROCESS | 1987 | 04:03:24 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:51814/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51814/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:03:24 INFO - PROCESS | 1987 | RSS: Main: 321044480 04:03:24 INFO - PROCESS | 1987 | 04:03:26 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:51814/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51814/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:03:27 INFO - PROCESS | 1987 | RSS: Main: 327876608 04:03:27 INFO - PROCESS | 1987 | 04:03:29 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:51814/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51814/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:03:30 INFO - PROCESS | 1987 | RSS: Main: 329650176 04:03:30 INFO - PROCESS | 1987 | 04:03:33 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:51814/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:03:33 INFO - PROCESS | 1987 | RSS: Main: 334630912 04:03:33 INFO - PROCESS | 1987 | 04:03:36 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:51814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:03:37 INFO - PROCESS | 1987 | RSS: Main: 332083200 04:03:37 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:51814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51814/tests/kraken/driver.html?testName=ai-astar) 04:03:39 INFO - PROCESS | 1987 | RSS: Main: 396247040 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | __start_tp_report 04:03:39 INFO - PROCESS | 1987 | _x_x_mozilla_page_load 04:03:39 INFO - PROCESS | 1987 | _x_x_mozilla_page_load_details 04:03:39 INFO - PROCESS | 1987 | |i|pagename|runs| 04:03:39 INFO - PROCESS | 1987 | |0;ai-astar;113;114;92;124;168;166;113;112;106;106 04:03:39 INFO - PROCESS | 1987 | |1;audio-beat-detection;158;120;130;176;150;172;168;120;171;118 04:03:39 INFO - PROCESS | 1987 | |2;audio-dft;186;183;184;186;183;184;183;180;181;183 04:03:39 INFO - PROCESS | 1987 | |3;audio-fft;77;71;87;91;55;59;56;84;95;79 04:03:39 INFO - PROCESS | 1987 | |4;audio-oscillator;93;96;143;78;80;80;125;79;76;128 04:03:39 INFO - PROCESS | 1987 | |5;imaging-gaussian-blur;88;84;89;87;135;130;89;85;90;85 04:03:39 INFO - PROCESS | 1987 | |6;imaging-darkroom;94;95;95;94;97;94;92;148;150;93 04:03:39 INFO - PROCESS | 1987 | |7;imaging-desaturate;86;86;85;92;84;84;86;83;87;84 04:03:39 INFO - PROCESS | 1987 | |8;json-parse-financial;59;59;59;57;58;58;59;76;58;58 04:03:39 INFO - PROCESS | 1987 | |9;json-stringify-tinderbox;63;62;73;78;64;72;69;80;99;97 04:03:39 INFO - PROCESS | 1987 | |10;stanford-crypto-aes;82;87;103;103;82;81;82;81;82;81 04:03:39 INFO - PROCESS | 1987 | |11;stanford-crypto-ccm;153;155;137;139;135;154;148;137;178;140 04:03:39 INFO - PROCESS | 1987 | |12;stanford-crypto-pbkdf2;174;172;172;174;170;177;173;188;170;170 04:03:39 INFO - PROCESS | 1987 | |13;stanford-crypto-sha256-iterative;69;70;70;68;67;72;67;69;68;70 04:03:39 INFO - PROCESS | 1987 | __end_tp_report 04:03:39 INFO - PROCESS | 1987 | __start_cc_report 04:03:39 INFO - PROCESS | 1987 | _x_x_mozilla_cycle_collect,2019 04:03:39 INFO - PROCESS | 1987 | __end_cc_report 04:03:39 INFO - PROCESS | 1987 | __startTimestamp1461409419325__endTimestamp 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | ------- Summary: start ------- 04:03:39 INFO - PROCESS | 1987 | Number of tests: 14 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | [#0] ai-astar Cycles:10 Average:121.40 Median:119.00 stddev:25.36 (21.3%) stddev-sans-first:26.72 04:03:39 INFO - PROCESS | 1987 | Values: 113.0 114.0 92.0 124.0 168.0 166.0 113.0 112.0 106.0 106.0 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:163.00 stddev:24.00 (14.7%) stddev-sans-first:25.20 04:03:39 INFO - PROCESS | 1987 | Values: 158.0 120.0 130.0 176.0 150.0 172.0 168.0 120.0 171.0 118.0 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:1.89 (1.0%) stddev-sans-first:1.73 04:03:39 INFO - PROCESS | 1987 | Values: 186.0 183.0 184.0 186.0 183.0 184.0 183.0 180.0 181.0 183.0 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | [#3] audio-fft Cycles:10 Average:75.40 Median:81.50 stddev:14.65 (18.0%) stddev-sans-first:15.53 04:03:39 INFO - PROCESS | 1987 | Values: 77.0 71.0 87.0 91.0 55.0 59.0 56.0 84.0 95.0 79.0 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:79.50 stddev:24.89 (31.3%) stddev-sans-first:26.34 04:03:39 INFO - PROCESS | 1987 | Values: 93.0 96.0 143.0 78.0 80.0 80.0 125.0 79.0 76.0 128.0 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | [#5] imaging-gaussian-blur Cycles:10 Average:96.20 Median:87.50 stddev:19.27 (22.0%) stddev-sans-first:20.21 04:03:39 INFO - PROCESS | 1987 | Values: 88.0 84.0 89.0 87.0 135.0 130.0 89.0 85.0 90.0 85.0 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | [#6] imaging-darkroom Cycles:10 Average:105.20 Median:94.00 stddev:23.13 (24.6%) stddev-sans-first:24.17 04:03:39 INFO - PROCESS | 1987 | Values: 94.0 95.0 95.0 94.0 97.0 94.0 92.0 148.0 150.0 93.0 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:2.54 (3.0%) stddev-sans-first:2.69 04:03:39 INFO - PROCESS | 1987 | Values: 86.0 86.0 85.0 92.0 84.0 84.0 86.0 83.0 87.0 84.0 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:59.00 stddev:5.63 (9.5%) stddev-sans-first:5.95 04:03:39 INFO - PROCESS | 1987 | Values: 59.0 59.0 59.0 57.0 58.0 58.0 59.0 76.0 58.0 58.0 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:75.50 stddev:13.22 (17.5%) stddev-sans-first:13.20 04:03:39 INFO - PROCESS | 1987 | Values: 63.0 62.0 73.0 78.0 64.0 72.0 69.0 80.0 99.0 97.0 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:82.00 stddev:8.92 (10.9%) stddev-sans-first:9.32 04:03:39 INFO - PROCESS | 1987 | Values: 82.0 87.0 103.0 103.0 82.0 81.0 82.0 81.0 82.0 81.0 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:150.50 stddev:13.18 (8.8%) stddev-sans-first:13.84 04:03:39 INFO - PROCESS | 1987 | Values: 153.0 155.0 137.0 139.0 135.0 154.0 148.0 137.0 178.0 140.0 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:173.50 stddev:5.40 (3.1%) stddev-sans-first:5.72 04:03:39 INFO - PROCESS | 1987 | Values: 174.0 172.0 172.0 174.0 170.0 177.0 173.0 188.0 170.0 170.0 04:03:39 INFO - PROCESS | 1987 | 04:03:39 INFO - PROCESS | 1987 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.56 (2.2%) stddev-sans-first:1.66 04:03:39 INFO - PROCESS | 1987 | Values: 69.0 70.0 70.0 68.0 67.0 72.0 67.0 69.0 68.0 70.0 04:03:39 INFO - PROCESS | 1987 | -------- Summary: end -------- 04:03:39 INFO - PROCESS | 1987 | 04:03:40 INFO - TEST-INFO | 1987: exit 0 04:03:40 INFO - TEST-OK | kraken | took 59273ms 04:03:40 INFO - SUITE-END | took 1174s 04:03:40 INFO - Completed test suite (00:19:34) 04:03:40 INFO - javascript benchmark 04:03:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2818.464491746568, 3418.3676019936315, 3428.7942723436595, 3446.327966046622, 3523.9471407928886, 5507.9449205508035, 5612.69130197839, 5637.830865074049, 5642.238297829792, 5649.23735295735, 5321.175217841241, 5638.633488823224, 5707.058335374669, 5742.885142297151, 5755.39568345324, 5098.541131298182, 5108.182690769478, 5138.665986710852, 5140.485951404867, 5212.791488340462, 5218.269442278084, 5242.18746094356, 5254.054270231357, 5254.710990895499, 5303.787848486056, 5072.1630930896545, 5135.820246291362, 5189.117849965515, 5191.610629202806, 5197.5322220999915, 5133.204353325241, 5185.6888586684545, 5187.118189907725, 5194.584433245369, 5254.500822421864, 5131.692098474066, 5147.279380886679, 5173.3533308336455, 5197.0385478686185, 5224.190250511177, 5425.02349577076, 5534.391216966131, 5537.8061767837935, 5540.418256083093, 5544.417836127229, 6124.3809352984035, 6204.81385558434, 6233.065040243954, 6233.563650544464, 6240.344763799781, 6227.501799856046, 6278.811635650938, 6311.305756366796, 6312.621242725451, 6317.873642527124, 5602.775888964477, 5756.683382413966, 5757.337906140806, 5762.827115186551, 5762.97118514409, 6236.314005459396, 6311.495080393557, 6330.968345158245, 6339.492840572743, 6358.650274234869, 4976.950230497649, 6095.299040610298, 6098.939010609926, 6101.176341193971, 6109.5112391008615, 6120.234970628671, 6164.198654174928, 6260.686965651699, 6269.0, 6284.402981716729, 6100.157317757059, 6106.673025714474, 6132.356102609251, 6135.0, 6159.23009623797, 6230.532710046765, 6233.844153896098, 6240.344763799826, 6245.156903817927, 6255.061740738925, 4103.4460347853255, 4889.997550502138, 4906.803727850917, 4955.776990035457, 4962.330085438492, 4302.26861433557, 4308.913821723548, 4404.273294906305, 4430.4683437987005, 4437.955620443754, 5622.887542249132, 5642.379338272786, 5647.124695672177, 5661.094224923992, 5664.518515926193, 6241.937580624226, 6275.341089185661, 6297.27581328144, 6306.085617585424, 6334.0, 5524.779008839681, 5571.554275658019, 5601.579881508903, 5606.159076138611, 5615.129654903497, 4454.309582014793, 5345.3852806926925, 5364.651297665718, 5376.4085950545405, 5448.237246785453, 6325.335839736854, 6336.778212762623, 6346.30190679025, 6351.936480635134, 6367.490600752021, 6245.156903817927, 6294.464970477561, 6300.401461861115, 6304.0, 6309.463695585927, 6261.123442717932, 6270.184875966095, 6348.174737284124, 6348.523860710373, 6354.142190804182, 6062.393760623902, 6075.969620151871, 6079.969600152148, 6089.786857459968, 6095.207623008981, 5063.215201643751, 6117.632942023492, 6137.844210862897, 6144.556029333193, 6302.212223472066, 5223.69407648088, 6113.327533971348, 6124.54065945047, 6139.508839292936, 6141.631502109709, 5789.739461724317, 6047.576669633084, 6061.696915154313, 6065.7876974307455, 6071.696415179135, 5760.1935728998815, 5838.970805145947, 5852.795152169653, 5868.765249389977, 5876.059830427112, 5191.8318378364565, 5311.973440132774, 5785.3636100028125, 5828.94171058301, 5836.883262334644, 5875.441833025856, 5916.733746981482, 5949.672767997802, 5981.431763982415, 5981.910271346021], "value": 5629.454716602837, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.0932976620682, 529.9576033917285, 531.0467710459725, 531.3650188025312, 547.8219578636944, 38117.23765524688, 39370.60629393705, 39580.0, 39583.20833583327, 39712.014399280066, 41516.16967660645, 42177.945551361154, 42332.153356932846, 42365.72902812921, 42444.0, 8628.137186281385, 8862.556872156398, 9589.37669051513, 9836.163926066292, 9842.114209721123, 9453.905460945405, 12035.097367697457, 12050.758984820299, 12068.879311206863, 12089.516419343216, 10908.0, 11600.0, 11721.882781172164, 11724.706882327968, 11798.997085247764, 8755.299576033902, 11656.941715291412, 11677.474513646906, 11946.0, 11970.461329240205, 11639.534418623245, 11795.528178872835, 11811.173217874752, 11820.881791182064, 11823.527058917633, 40590.0, 40840.0, 40843.59156408428, 40894.0, 40998.59001409978, 3231.062991732395, 3242.0, 3294.2423242654086, 3369.5956485221686, 3579.699530888152, 24095.397615059588, 25891.482170356674, 29223.56164657532, 29251.56122658162, 29909.6540655671, 2705.9323516912036, 2706.431649353638, 2710.7966902482394, 2711.2137480130737, 2888.292368369742, 420495.0, 511966.0, 512179.0, 512571.9999999963, 513569.0, 61670.0, 62032.37967620356, 62509.0, 62646.68676656587, 62705.05942410776, 65789.34210657928, 68510.0, 70467.64766176137, 70491.0, 70522.2947770526, 16737.748933766004, 16911.900726452743, 16975.368817833256, 16978.745318820227, 17011.744823827652, 11892.167548271538, 12144.33206173669, 12909.677258068436, 13247.00647451445, 13263.801042984363, 19213.423597292105, 19266.518337041685, 19340.4197874064, 19395.224191032485, 19410.320638777575, 6795.0, 8008.919910800934, 8223.301019413417, 8274.462159959583, 8303.626336814857, 799.8240387114826, 983.7079604521448, 1076.671615157369, 1147.8794726553758, 1173.501261963662, 29221.853890730836, 29276.0, 29446.705532944397, 30162.24594385114, 30174.24564385864, 1024.1857723110145, 1094.7427354571669, 1210.3827048205303, 1220.45079714129, 1224.6203676860202, 15244.847551524565, 15377.9231103846, 15412.306446209723, 15434.131661941681, 15542.0, 651153.0, 663026.0, 663232.0, 663867.0, 664227.0, 59445.0, 61702.0, 61727.38272617216, 61868.69065654733, 61933.38066619276, 1197.8261303922031, 1303.4199781097511, 1327.9601611951657, 1414.1515090945556, 1574.661447788708, 22407.551848962605, 29962.0, 30484.683755257905, 30954.0, 32597.837010814794, 53581.73209133929, 54006.0, 54199.64500887509, 54357.45642543524, 54399.0, 494428.0, 498881.0, 499083.5412406523, 499239.0, 499883.0, 21461.46346341354, 23703.05187792538, 24252.393690157885, 26931.596026060015, 27110.1866943992, 43492.56507434885, 45149.87125321893, 45184.54815451804, 45669.0, 46254.30618540792, 36855.0, 36865.63134368622, 36919.630803691616, 37788.81105594454, 37838.62161378351, 32660.673393266712, 36454.4531832028, 36634.63365366312, 36832.26335473329, 37657.0, 34360.82819585886, 36597.634023659426, 37763.0, 37776.6778162763, 37848.62151378451, 31432.685673142976, 32233.51649725303, 32255.35489290248, 32326.0, 32357.838210809736, 23579.521339012612, 24076.277711668678, 24179.680470296506, 24539.754602453748, 24554.50890982206], "value": 20253.69185909851, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.2135282816438, 400.119736579525, 402.7221217360023, 404.08273219791096, 414.31844615607326, 14959.775603365959, 19904.90047549762, 20881.582368352643, 20946.685799713, 21539.67690484644, 16220.513384598451, 18407.0, 20258.59482810343, 20644.89677551614, 21140.365789026353, 5975.253093363319, 6150.6924653767355, 6197.194364732579, 6206.875862482748, 6207.81376558704, 6029.155918171459, 6084.756609735606, 6086.665233412161, 6102.359252278514, 6168.352323006087, 5881.647101173922, 6094.695265236743, 6103.298120716108, 6105.908411373833, 6127.387261273881, 5785.768569257225, 6037.7584896604085, 6152.630842149485, 6152.630842149485, 6158.8768224635705, 5693.601447898649, 5915.1718759373725, 5925.170476133345, 5931.73307201177, 5940.198073260098, 25961.221163364942, 26214.0, 26291.34271643205, 26668.93324267027, 26752.73247267522, 2065.8037486438916, 2081.0427203486415, 2084.5414008918015, 2092.1526781653456, 2124.9043793029196, 9657.806843863083, 9972.90027099727, 10099.747506312327, 15023.549293521211, 15173.696526069416, 1706.598949246926, 1722.5865792209904, 1766.1081154017268, 1784.9107544622716, 1798.0560205891882, 99077.50461247719, 115306.11734706616, 118911.0, 122975.54048918972, 128917.0, 9585.376950498196, 11444.713882152846, 11712.70718232051, 11952.880471195176, 12035.0, 15384.15387153695, 15451.922740386452, 15458.0, 15479.922600386926, 15484.993475424286, 6857.417119544894, 7552.546847189186, 7968.521888686697, 8721.825563488695, 8890.288776897833, 7020.473464490184, 7194.820129496699, 8661.220490155916, 8727.65089396417, 8780.956095219612, 4605.171069207575, 4658.8120029392285, 4694.319323698045, 4743.407074115736, 4760.880977975578, 1914.9425517234506, 1975.8221760041379, 1980.8415326773822, 1992.1035534009463, 2020.5251765835017, 852.7271273192642, 921.1019256225127, 990.8761404824397, 996.4619105682995, 1029.7991891581219, 20981.265655701976, 21542.784572154076, 21689.981983240894, 21755.782442175376, 22612.434689132904, 914.401067300919, 922.9123233292827, 957.4255446732044, 1008.7377281906611, 1032.2052019944751, 10972.615958441416, 11318.547258109584, 11345.09239260857, 11377.943110284561, 11408.429578521042, 577264.0, 583015.0, 588604.0, 603151.0, 606279.0, 73678.0, 126166.0, 129093.35453322862, 135267.32366338104, 138497.61502384848, 1039.2673165418362, 1044.9111825494917, 1069.1820757120809, 1081.848541204232, 1087.7117563845586, 18647.44057678272, 18793.34223302178, 18829.717554236973, 18856.52858678544, 18870.150843211813, 50588.988220234656, 51309.23036154536, 51935.48064519458, 51984.74007629938, 52319.47680523146, 72465.27534724586, 74557.6272118636, 74740.50518989698, 74994.25005749872, 78240.43519129472, 6805.421539169226, 7737.0, 7967.163447838126, 8140.959295203486, 8366.163383661586, 10502.632407865687, 11889.702757430787, 12267.938660306641, 12322.39808824847, 12368.505259789868, 10756.031957123896, 10766.407847568458, 10801.189910756882, 10821.296615720268, 10912.563497460013, 10523.263371563917, 10554.788904222027, 10691.30506517074, 10790.622328218475, 10946.671599852018, 10952.452377381258, 11090.168237382068, 11284.661460156209, 11403.828942566033, 11477.139214558774, 8028.1169071403265, 8071.919280807351, 8171.918280817115, 8180.345572354317, 8269.83460330802, 8108.3513318933165, 9945.80650321966, 10831.241813073324, 11068.5572577096, 11179.888201117885], "value": 9593.29773629244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.30726329572, 1446.9437310763142, 1463.8828893688503, 1779.6440711857624, 1988.0556735550615, 7820.257075577818, 8517.616707248173, 8811.295096392289, 8818.779530511725, 8830.426022308562, 8428.873566896502, 8675.869861952076, 8680.826383472328, 8688.304935605152, 8705.042445331008, 2434.9878250608767, 2464.223769512607, 2465.494573612405, 2468.814838887082, 2470.3824043989002, 2402.5555272274596, 2464.5933420985516, 2464.8890799913956, 2469.938251543708, 2474.9010039598393, 2077.366403247009, 2423.624338227569, 2440.8413453125577, 2455.165243817102, 2462.310553045141, 2367.1005018093188, 2392.712874455059, 2396.628522579003, 2402.2072716003763, 2414.6619473273754, 2364.775346342095, 2391.1033362489065, 2398.5322862041908, 2399.568077746005, 2401.3156250468533, 8507.447015943944, 8711.08533603975, 8727.956360218159, 8797.736067917973, 8823.823523529558, 5159.819406320761, 5355.571554275649, 5362.356517217959, 5370.409254981949, 5378.354597448331, 3485.7734247273847, 3494.9650503494895, 3570.8571657133684, 3592.1199306170156, 3597.4963505109304, 1017.115109854424, 1028.239103063735, 1028.8816786069624, 1037.2065369991963, 1042.9947850260776, 11277.266977646426, 11601.825972610417, 11616.825747613793, 11626.941865290704, 11670.883291167149, 3814.9127498662747, 4249.851255206115, 4603.562661547147, 4697.037107393045, 4697.95302046982, 9071.047540008203, 9077.818443631091, 9078.682246121487, 9094.045125261884, 9109.18017378439, 5219.791208351623, 5242.97378513105, 5268.209768534751, 5269.104252277122, 5281.762320695578, 4352.064306174188, 4537.842850073276, 4744.786484608201, 4874.317595536628, 4924.4583095859425, 3736.9065773355883, 3780.6597406233573, 3852.24881148179, 3853.499045124116, 3886.7862267575556, 1186.5965571705663, 1190.7558950415316, 1190.9047276217882, 1196.4137572589368, 1204.5121725701106, 677.9762708305186, 826.3760860550366, 900.7027680865299, 966.8066386722684, 984.3896783993827, 5711.628744131618, 5872.207252021008, 5929.673867937218, 5933.021051526536, 5934.1692163097205, 479.92321228603254, 487.64645631917284, 492.36730800920645, 496.5371756089835, 583.5818959927417, 3746.812659367021, 3979.945314491662, 4041.939370909439, 4081.673466122703, 4083.673306135502, 9976.80046399068, 10749.193810464247, 10854.131669466424, 10857.67426977192, 10882.727931801768, 10454.477276136315, 10607.840882386616, 10649.254552181428, 10694.893051069545, 10801.297915635458, 8108.9594552026865, 8124.5937703114605, 8178.5092894426525, 8218.342532597379, 8226.629801659059, 5678.3753787084215, 5752.424757524214, 5839.854003649943, 5905.379935106752, 5910.881782364415, 9672.93597704238, 9856.063673950963, 10004.199664027006, 10005.449700266556, 10008.249381296286, 9833.852492212765, 9850.113489785954, 10077.445740484343, 10190.98090190975, 10256.743581410525, 6885.8967115492305, 6911.205211400753, 6956.652167391509, 6972.372486476242, 6984.371406573433, 8052.194780521901, 8064.758057258292, 8117.1071182168735, 8157.918420815953, 8165.265126138676, 7374.926250737424, 7418.703251870081, 7458.5151965122095, 7502.699892004477, 7577.431692622965, 7274.236205198589, 7280.0, 7364.116306043309, 7390.96304518474, 7455.7017719290625, 6696.397324240842, 7007.983842342934, 7008.474364422586, 7010.964945175446, 7017.754378596725, 3783.0353259918543, 4803.423589169322, 4864.562189402971, 4872.14737420957, 5102.158143906214, 4913.70517768935, 5013.097642424399, 5035.748212589283, 5038.571721403721, 5042.0], "value": 4462.595757299753, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.42511503488464, 313.95290706394036, 324.6364072239092, 327.0466589890468, 327.4662300450266, 4909.459959404468, 5856.414358564147, 5886.205362276091, 5927.103326935382, 5997.37027612101, 5610.607257491977, 5642.858928526789, 5847.619904706191, 5857.26784151981, 5945.346011938684, 4394.6703997200175, 4488.955110448903, 4489.820407183709, 4508.797104130305, 4509.639228861692, 4490.777065352655, 4502.189605870958, 4507.256302710065, 4509.25597276449, 4520.932186017212, 3514.787398347579, 4473.306637471181, 4474.172278128541, 4480.148771733377, 4495.43807024122, 4423.646108311327, 4440.667799660089, 4460.933086003713, 4480.686351955364, 4514.909701805946, 3594.658507441789, 3920.5491368492703, 3924.274009308287, 3927.9214415711526, 3928.7839168845703, 5518.902816929582, 5648.830535083954, 5674.716264186774, 5674.9716251418895, 5698.487136157766, 4088.3663032229756, 4408.118376324748, 4920.852374428773, 5044.117279476077, 5145.30538377318, 6022.0, 6218.160548325964, 6231.781887633956, 6254.903822607793, 6292.62244265341, 3569.6787289144104, 3910.667593254577, 4228.894277643053, 4288.871333859958, 4299.441072660566, 5351.464853514656, 6526.118973938505, 6588.538802283842, 6608.257573107155, 6619.93380066198, 3774.6036666150208, 4271.782541975522, 4377.321515165155, 4378.56214378566, 4403.163398954189, 4044.8179831907637, 4304.461942257218, 4321.935170972438, 4333.826646934087, 4337.392765012901, 4819.566239038503, 5014.84955451337, 5015.0, 5076.6192535559985, 5089.982003599295, 5919.3192782829665, 6308.684565771693, 6317.652529110851, 6320.5349913533755, 6330.335314791972, 1297.6172029251393, 1329.1028555724847, 1438.6475313548037, 1466.5746933389412, 1501.9549413517611, 947.6067432015636, 957.2533423929347, 972.7568107973007, 973.0658567775015, 974.152487336008, 4767.73777442244, 5747.298769578291, 5751.942480575224, 5758.2514273144225, 5801.50687191585, 5620.932022915633, 6113.0, 6418.550701450854, 6421.550491465552, 6424.49024479247, 4764.475907650225, 5425.430329815313, 5426.810061647823, 5727.942720572741, 5760.193572899798, 3355.2282974915906, 3375.4093033719, 3406.386850366908, 3408.965910340865, 3424.931501369959, 6468.0, 6659.0, 6672.0, 6685.732570697215, 6710.429613482908, 6526.151600292027, 6545.14913061299, 6553.57401768893, 6568.376004279586, 6572.80281591553, 6508.893488106938, 6633.502487313374, 6652.268250492442, 6662.467002639777, 6666.933330666729, 6294.4964402846745, 6339.207599050119, 6383.680815959091, 6384.840378990562, 6394.328595497592, 5315.282436870973, 6157.9384206157365, 6275.152854364785, 6304.460788232649, 6304.7162877671535, 5404.8919971404985, 5984.371640977809, 6332.30344662096, 6634.919524492306, 6708.6981085850275, 4205.411242426124, 4215.473065866767, 4222.239996800606, 4237.982884107853, 4239.639630631431, 5235.476452354734, 6120.0, 6245.843853903507, 6370.140031095742, 6406.647634380154, 4894.681845680019, 5663.536361682682, 6069.696515174312, 6183.721732522137, 6357.029320910533, 6261.7182226799, 6275.6548389839, 6307.905381419374, 6314.6842657866, 6318.526110541819, 4890.779914903909, 5124.976264004255, 5273.525382715574, 6059.363766804422, 6237.345078766664, 6172.351903050115, 6239.313675495601, 6255.155554000152, 6312.747490100528, 6316.652584107918, 5776.971115144397, 6167.889779839672, 6170.500947116425, 6181.783637572664, 6203.627782333075], "value": 4539.713455189608, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.2596852572331, 729.0413106764607, 734.6987735028639, 741.758928348287, 743.4613464361804, 14893.255337233135, 15031.624209394771, 15306.158161301124, 15328.770068448983, 15347.155906425129, 13948.02363834532, 14056.15663060217, 14156.433742650283, 14172.007959442843, 14181.361838717257, 735.7020406735281, 756.6065645864174, 920.4201353147524, 924.4499522783966, 925.0703043441366, 898.3890954151175, 944.5607792376578, 947.2469386837481, 947.9383840050375, 948.3503799897059, 985.1527686189871, 994.6717583197563, 996.0885789502596, 997.5560875410446, 999.1307562420668, 765.4144579396766, 960.9087136722001, 986.9851952220722, 988.4464699768153, 989.1098011789376, 734.1887214627866, 736.054170391045, 737.6090671943824, 738.0774032459426, 743.8103283662685, 15311.0, 15372.0, 15387.923060384739, 15391.153486558234, 15396.230188490643, 12153.756924861542, 12290.207083897149, 12334.75330493394, 12452.439640216122, 12481.313527756061, 10142.645007424704, 10163.949180254125, 10193.184545236363, 10580.994805493467, 10662.946685266601, 4029.979850100731, 4105.835766569364, 4133.111381053088, 4210.45264115666, 4308.0, 82418.17581824165, 82716.0, 82797.58601207015, 84053.57973210094, 84623.15376846214, 9198.816023679488, 9581.712548623413, 9676.70969870905, 9727.221822254203, 10008.949955250177, 21638.675419868716, 21705.67441488379, 21708.674369884466, 21742.0, 21748.13007479683, 7420.851582968418, 7474.3273105419685, 7536.208698086732, 7587.810304742426, 7616.8476630467085, 4074.6943979201087, 4143.150654115899, 4150.236985701204, 4151.875443736692, 4430.712003719748, 3627.6372362763514, 3668.761530500509, 3668.853245870135, 3701.7038636908983, 3704.481372607837, 658.7957733102753, 659.8548319369827, 665.9467242620578, 666.6400143922325, 668.5554106519207, 479.8296604705349, 501.40522794538117, 505.184127633876, 580.523970344322, 593.6289818863211, 7574.5076570022775, 7813.453058285979, 8032.1164671886045, 8069.0317161939765, 8094.15011423792, 543.7575140803245, 558.4917724870348, 567.7615401531367, 598.317917573966, 623.4420193926501, 3840.7695538267794, 3841.4814000109627, 3888.4556162137324, 3918.1967696622123, 3922.2351641429645, 81712.0, 81871.18128818755, 82728.58635706783, 83134.75297870536, 85952.57023714966, 59297.40702592919, 74887.62556187184, 75789.24210757822, 77976.22023779803, 78873.4225315502, 67014.32985670178, 69419.30580694128, 69599.65200174067, 69901.0, 70080.0, 7503.399728021636, 7568.880713400256, 7676.577788221478, 7742.883856742041, 7756.1468238494845, 31736.0, 43365.0, 44470.0, 44896.77551612352, 45025.0, 59581.0, 60285.69857150862, 63015.0, 64409.67795160994, 64435.03347449698, 9710.689056977217, 9912.702618921443, 10019.649312274036, 10142.391456512632, 10188.592456301962, 10365.637202698172, 10636.468176591294, 10741.140708743438, 10936.343819370863, 11299.152563557602, 8070.757877263692, 10316.0, 11634.0, 11731.589394371156, 11974.042076634023, 11102.111831053659, 11165.38590377537, 11181.273217240854, 11873.940630296793, 12038.458269378074, 10823.803990604361, 11111.11111111093, 11348.886511135113, 11382.601608943647, 11395.544178232778, 9518.61925522999, 9637.37357071788, 9642.614295428104, 9966.900330996597, 10065.647702330383, 8380.371472139492, 9098.999110098017, 9811.901880981384, 9820.45987470696, 9928.021593522059], "value": 6817.5101313374735, "unit": "score"}], "name": "dromaeo_css", "value": 7298.001576413316, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 92.0, 124.0, 168.0, 166.0, 113.0, 112.0, 106.0, 106.0], "value": 121.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 120.0, 130.0, 176.0, 150.0, 172.0, 168.0, 120.0, 171.0, 118.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 184.0, 186.0, 183.0, 184.0, 183.0, 180.0, 181.0, 183.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 71.0, 87.0, 91.0, 55.0, 59.0, 56.0, 84.0, 95.0, 79.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 143.0, 78.0, 80.0, 80.0, 125.0, 79.0, 76.0, 128.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 89.0, 87.0, 135.0, 130.0, 89.0, 85.0, 90.0, 85.0], "value": 96.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 97.0, 94.0, 92.0, 148.0, 150.0, 93.0], "value": 105.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 92.0, 84.0, 84.0, 86.0, 83.0, 87.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 57.0, 58.0, 58.0, 59.0, 76.0, 58.0, 58.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 73.0, 78.0, 64.0, 72.0, 69.0, 80.0, 99.0, 97.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 103.0, 103.0, 82.0, 81.0, 82.0, 81.0, 82.0, 81.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 155.0, 137.0, 139.0, 135.0, 154.0, 148.0, 137.0, 178.0, 140.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 172.0, 174.0, 170.0, 177.0, 173.0, 188.0, 170.0, 170.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 68.0, 67.0, 72.0, 67.0, 69.0, 68.0, 70.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1526.1000000000001, "alertThreshold": 2.0}]} 04:03:40 INFO - Return code: 0 04:03:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:03:40 ERROR - # TBPL SUCCESS # 04:03:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:03:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:03:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:03:40 INFO - 2016-04-23 04:03:40.641 screenresolution[1991:18134] starting screenresolution argv=screenresolution get 04:03:40 INFO - 2016-04-23 04:03:40.644 screenresolution[1991:18134] Display 0: 1600x1200x32@60 04:03:40 INFO - 2016-04-23 04:03:40.650 screenresolution[1992:18138] starting screenresolution argv=screenresolution list 04:03:40 INFO - Available Modes on Display 0 04:03:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:03:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:03:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:03:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:03:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:03:40 INFO - Intel Iris: 04:03:40 INFO - Chipset Model: Intel Iris 04:03:40 INFO - Type: GPU 04:03:40 INFO - Bus: Built-In 04:03:40 INFO - VRAM (Dynamic, Max): 1536 MB 04:03:40 INFO - Vendor: Intel (0x8086) 04:03:40 INFO - Device ID: 0x0a2e 04:03:40 INFO - Revision ID: 0x0009 04:03:40 INFO - Displays: 04:03:40 INFO - Display: 04:03:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:03:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:03:40 INFO - Display Serial Number: 1600x1200 60 04:03:40 INFO - Main Display: Yes 04:03:40 INFO - Mirror: Off 04:03:40 INFO - Online: Yes 04:03:40 INFO - Rotation: Supported 04:03:40 INFO - Return code: 0 04:03:40 INFO - Running post-action listener: _resource_record_post_action 04:03:40 INFO - Running post-run listener: _resource_record_post_run 04:03:41 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 720896; Write bytes: 695416832; Read time: 10; Write time: 2056 04:03:41 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 395665920; Write bytes: 394401792; Read time: 30082; Write time: 728 04:03:41 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 720896; Write bytes: 296955904; Read time: 10; Write time: 1312 04:03:41 INFO - Running post-run listener: _upload_blobber_files 04:03:41 INFO - Blob upload gear active. 04:03:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:03:41 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 04:03:41 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'] 04:03:41 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 04:03:42 INFO - (blobuploader) - INFO - Open directory for files ... 04:03:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:03:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:03:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:43 INFO - (blobuploader) - INFO - Done attempting. 04:03:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:03:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:03:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:44 INFO - (blobuploader) - INFO - Done attempting. 04:03:44 INFO - (blobuploader) - INFO - Iteration through files over. 04:03:44 INFO - Return code: 0 04:03:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:03:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:03:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/391765fd33fa79a31107c0decc2c008d1f1e868c28903f5d94d6ec64fc4967d260245d1e69679c9327b3e2c7bdf95b5b25e281dfd101847457c0e46182fb0cb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47b36f6f3644b8b070d090d036e6bdb1c000f1f1c67748c56f45cabcd1e90926536132f2a3d1116e0d02be597905f524fefb22d5429a5d69b2d2e664c76a0d84"} 04:03:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:03:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:03:44 INFO - Contents: 04:03:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/391765fd33fa79a31107c0decc2c008d1f1e868c28903f5d94d6ec64fc4967d260245d1e69679c9327b3e2c7bdf95b5b25e281dfd101847457c0e46182fb0cb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47b36f6f3644b8b070d090d036e6bdb1c000f1f1c67748c56f45cabcd1e90926536132f2a3d1116e0d02be597905f524fefb22d5429a5d69b2d2e664c76a0d84"} 04:03:44 INFO - Running post-run listener: copy_logs_to_upload_dir 04:03:44 INFO - Copying logs to upload dir... 04:03:44 INFO - mkdir: /builds/slave/test/build/upload/logs 04:03:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.104646 ========= master_lag: 14.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-04-23 04:03:59.396075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-23 04:03:59.399668) ========= 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.FEml56lpWq/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.H8lL0Qgwnu/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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/391765fd33fa79a31107c0decc2c008d1f1e868c28903f5d94d6ec64fc4967d260245d1e69679c9327b3e2c7bdf95b5b25e281dfd101847457c0e46182fb0cb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47b36f6f3644b8b070d090d036e6bdb1c000f1f1c67748c56f45cabcd1e90926536132f2a3d1116e0d02be597905f524fefb22d5429a5d69b2d2e664c76a0d84"} build_url:https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011107 build_url: 'https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/391765fd33fa79a31107c0decc2c008d1f1e868c28903f5d94d6ec64fc4967d260245d1e69679c9327b3e2c7bdf95b5b25e281dfd101847457c0e46182fb0cb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47b36f6f3644b8b070d090d036e6bdb1c000f1f1c67748c56f45cabcd1e90926536132f2a3d1116e0d02be597905f524fefb22d5429a5d69b2d2e664c76a0d84"}' ========= master_lag: 1.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-23 04:04:00.473753) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 04:04:00.474094) ========= 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.FEml56lpWq/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.H8lL0Qgwnu/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.005241 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 04:04:00.534719) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 04:04:00.535036) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 04:04:00.987253) ========= ========= Total master_lag: 15.63 =========