builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0112 starttime: 1461408141.11 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.108023) ========= 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.108472) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:21.108753) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:21.136351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:21.136640) ========= 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.nusMLK6lIi/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.dqZyZYZ5YX/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 40.2M=0s 2016-04-23 03:42:21 (40.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.491741 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:21.657379) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:21.657662) ========= 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.nusMLK6lIi/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.dqZyZYZ5YX/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.026996 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:21.714094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 03:42:21.714424) ========= 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.nusMLK6lIi/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.dqZyZYZ5YX/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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,784 truncating revision to first 12 chars 2016-04-23 03:42:21,784 Setting DEBUG logging. 2016-04-23 03:42:21,784 attempt 1/10 2016-04-23 03:42:21,784 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:22,845 unpacking tar archive at: mozilla-central-37f04460ddb7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.309658 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 03:42:23.042026) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:23.042440) ========= script_repo_revision: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:23.042838) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:23.043116) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 03:42:23.056537) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-04-23 03:42:23.056827) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nusMLK6lIi/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.dqZyZYZ5YX/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:23 INFO - MultiFileLogger online at 20160423 03:42:23 in /builds/slave/test 03:42:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:42:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:42:23 INFO - {'append_to_log': False, 03:42:23 INFO - 'base_work_dir': '/builds/slave/test', 03:42:23 INFO - 'blob_upload_branch': 'Firefox', 03:42:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:42:23 INFO - 'branch': 'Firefox', 03:42:23 INFO - 'buildbot_json_path': 'buildprops.json', 03:42:23 INFO - 'config_files': ('talos/mac_config.py',), 03:42:23 INFO - 'default_actions': ('clobber', 03:42:23 INFO - 'read-buildbot-config', 03:42:23 INFO - 'download-and-extract', 03:42:23 INFO - 'populate-webroot', 03:42:23 INFO - 'create-virtualenv', 03:42:23 INFO - 'install', 03:42:23 INFO - 'run-tests'), 03:42:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:42:23 INFO - 'download_minidump_stackwalk': True, 03:42:23 INFO - 'download_symbols': 'ondemand', 03:42:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:42:23 INFO - 'tooltool.py': '/tools/tooltool.py', 03:42:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:42:23 INFO - '/tools/misc-python/virtualenv.py')}, 03:42:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:42:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:42:23 INFO - 'installer_path': 'installer.exe', 03:42:23 INFO - 'log_level': 'info', 03:42:23 INFO - 'log_name': 'talos', 03:42:23 INFO - 'log_to_console': True, 03:42:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:42:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:42:23 INFO - 'opt_config_files': (), 03:42:23 INFO - 'pip_index': False, 03:42:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:42:23 INFO - 'cmd': ('bash', 03:42:23 INFO - '-c', 03:42:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:42:23 INFO - 'enabled': True, 03:42:23 INFO - 'halt_on_failure': False, 03:42:23 INFO - 'name': 'check_screen_resolution'},), 03:42:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:42:23 INFO - 'cmd': ('bash', 03:42:23 INFO - '-c', 03:42:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:42:23 INFO - 'enabled': True, 03:42:23 INFO - 'halt_on_failure': False, 03:42:23 INFO - 'name': 'check_screen_resolution'},), 03:42:23 INFO - 'run_cmd_checks_enabled': True, 03:42:23 INFO - 'sps_profile': False, 03:42:23 INFO - 'sps_profile_interval': 0, 03:42:23 INFO - 'suite': 'dromaeojs-e10s', 03:42:23 INFO - 'system_bits': '32', 03:42:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:42:23 INFO - 'title': 't-yosemite-r7-0112', 03:42:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:42:23 INFO - 'use_talos_json': True, 03:42:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:42:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:42:23 INFO - 'work_dir': 'build'} 03:42:23 INFO - ##### 03:42:23 INFO - ##### Running clobber step. 03:42:23 INFO - ##### 03:42:23 INFO - Running pre-action listener: _resource_record_pre_action 03:42:23 INFO - Running main action method: clobber 03:42:23 INFO - rmtree: /builds/slave/test/build 03:42:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:42:24 INFO - Running post-action listener: _resource_record_post_action 03:42:24 INFO - ##### 03:42:24 INFO - ##### Running read-buildbot-config 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: read_buildbot_config 03:42:24 INFO - Using buildbot properties: 03:42:24 INFO - { 03:42:24 INFO - "project": "", 03:42:24 INFO - "product": "firefox", 03:42:24 INFO - "script_repo_revision": "production", 03:42:24 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:42:24 INFO - "repository": "", 03:42:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:42:24 INFO - "buildid": "20160423014751", 03:42:24 INFO - "pgo_build": "False", 03:42:24 INFO - "basedir": "/builds/slave/test", 03:42:24 INFO - "buildnumber": 253, 03:42:24 INFO - "slavename": "t-yosemite-r7-0112", 03:42:24 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:42:24 INFO - "platform": "yosemite_r7", 03:42:24 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:42:24 INFO - "branch": "mozilla-central", 03:42:24 INFO - "repo_path": "mozilla-central", 03:42:24 INFO - "revision": "37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776", 03:42:24 INFO - "stage_platform": "macosx64", 03:42:24 INFO - "builduid": "4a551be9d5ae4526a36020d2fad26a6a", 03:42:24 INFO - "slavebuilddir": "test" 03:42:24 INFO - } 03:42:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 03:42:24 INFO - Running post-action listener: _resource_record_post_action 03:42:24 INFO - ##### 03:42:24 INFO - ##### Running download-and-extract 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: download_and_extract 03:42:24 INFO - mkdir: /builds/slave/test/build/tests 03:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:24 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:33 INFO - Downloaded 1199 bytes. 03:42:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 03:42:33 INFO - Using the following test package requirements: 03:42:33 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:42:33 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:33 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 03:42:33 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:33 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 03:42:33 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:33 INFO - u'jsshell-mac.zip'], 03:42:33 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:33 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 03:42:33 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:42:33 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:33 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 03:42:33 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:33 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 03:42:33 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:33 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 03:42:33 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:42:33 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 03:42:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:33 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:33 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:33 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:33 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:33 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:38 INFO - Downloaded 18109620 bytes. 03:42:38 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:38 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:41 INFO - Return code: 0 03:42:41 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:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:41 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:41 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:41 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:41 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:41 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:47 INFO - Downloaded 18109620 bytes. 03:42:47 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:47 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:52 INFO - Downloaded 10840145 bytes. 03:42:52 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:52 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:52 INFO - Return code: 0 03:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:52 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:52 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:52 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:52 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:52 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:43:02 INFO - Downloaded 110134522 bytes. 03:43:02 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:43:02 INFO - mkdir: /builds/slave/test/properties 03:43:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:43:02 INFO - Writing to file /builds/slave/test/properties/build_url 03:43:02 INFO - Contents: 03:43:02 INFO - build_url:https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:43:04 INFO - Running post-action listener: _resource_record_post_action 03:43:04 INFO - Running post-action listener: set_extra_try_arguments 03:43:04 INFO - ##### 03:43:04 INFO - ##### Running populate-webroot step. 03:43:04 INFO - ##### 03:43:04 INFO - Running pre-action listener: _resource_record_pre_action 03:43:04 INFO - Running main action method: populate_webroot 03:43:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:43:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:43:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:43:04 INFO - '--tppagecycles', 03:43:04 INFO - '7'], 03:43:04 INFO - 'tests': ['tsvgm']}}, 03:43:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:43:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:43:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:43:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:43:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:43:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:43:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:04 INFO - 'talos_options': ['--disable-e10s'], 03:43:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:04 INFO - 'talos_options': ['--disable-e10s'], 03:43:04 INFO - 'tests': ['damp', 'tps']}, 03:43:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:04 INFO - 'tests': ['damp', 'tps']}, 03:43:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:43:04 INFO - 'tests': ['dromaeo_dom']}, 03:43:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:43:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:43:04 INFO - 'tests': ['a11yr', 03:43:04 INFO - 'ts_paint', 03:43:04 INFO - 'tpaint', 03:43:04 INFO - 'sessionrestore', 03:43:04 INFO - 'sessionrestore_no_auto_restore', 03:43:04 INFO - 'tabpaint']}, 03:43:04 INFO - 'other-e10s': {'tests': ['a11yr', 03:43:04 INFO - 'ts_paint', 03:43:04 INFO - 'tpaint', 03:43:04 INFO - 'sessionrestore', 03:43:04 INFO - 'sessionrestore_no_auto_restore', 03:43:04 INFO - 'tabpaint']}, 03:43:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:43:04 INFO - 'ts_paint', 03:43:04 INFO - 'tpaint', 03:43:04 INFO - 'sessionrestore', 03:43:04 INFO - 'sessionrestore_no_auto_restore', 03:43:04 INFO - 'tabpaint']}, 03:43:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:43:04 INFO - 'ts_paint', 03:43:04 INFO - 'tpaint', 03:43:04 INFO - 'sessionrestore', 03:43:04 INFO - 'sessionrestore_no_auto_restore', 03:43:04 INFO - 'tabpaint']}, 03:43:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:43:04 INFO - 'tests': ['a11yr', 03:43:04 INFO - 'ts_paint', 03:43:04 INFO - 'tpaint', 03:43:04 INFO - 'sessionrestore', 03:43:04 INFO - 'sessionrestore_no_auto_restore', 03:43:04 INFO - 'tabpaint']}, 03:43:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:43:04 INFO - 'tests': ['a11yr', 03:43:04 INFO - 'ts_paint', 03:43:04 INFO - 'tpaint', 03:43:04 INFO - 'sessionrestore', 03:43:04 INFO - 'sessionrestore_no_auto_restore', 03:43:04 INFO - 'tabpaint']}, 03:43:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:43:04 INFO - 'tests': ['tsvgx', 03:43:04 INFO - 'tsvgr_opacity', 03:43:04 INFO - 'tart', 03:43:04 INFO - 'tscrollx', 03:43:04 INFO - 'cart']}, 03:43:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:43:04 INFO - 'tsvgr_opacity', 03:43:04 INFO - 'tart', 03:43:04 INFO - 'tscrollx', 03:43:04 INFO - 'cart']}, 03:43:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:04 INFO - 'talos_options': ['--disable-e10s'], 03:43:04 INFO - 'tests': ['tp5o']}, 03:43:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:04 INFO - 'tests': ['tp5o']}, 03:43:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:04 INFO - 'talos_options': ['--disable-e10s', 03:43:04 INFO - '--xperf_path', 03:43:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:04 INFO - 'tests': ['tp5n']}, 03:43:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:04 INFO - 'talos_options': ['--xperf_path', 03:43:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:04 INFO - 'tests': ['tp5n']}}, 03:43:04 INFO - 'talos.zip': {'path': '', 03:43:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:43:04 INFO - Running post-action listener: _resource_record_post_action 03:43:04 INFO - ##### 03:43:04 INFO - ##### Running create-virtualenv step. 03:43:04 INFO - ##### 03:43:04 INFO - Running pre-action listener: _resource_record_pre_action 03:43:04 INFO - Running main action method: create_virtualenv 03:43:04 INFO - Creating virtualenv /builds/slave/test/build/venv 03:43:04 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:43:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:43:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:43:04 INFO - Using real prefix '/tools/python27' 03:43:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:43:05 INFO - Installing distribute.............................................................................................................................................................................................done. 03:43:07 INFO - Installing pip.................done. 03:43:07 INFO - Return code: 0 03:43:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a92ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a93e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb6bccdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7cde00>, '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 0x10a636db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a7c8b20>, '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.nusMLK6lIi/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.dqZyZYZ5YX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:43:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nusMLK6lIi/Render', 03:43:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:07 INFO - 'HOME': '/Users/cltbld', 03:43:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:07 INFO - 'LOGNAME': 'cltbld', 03:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:07 INFO - 'MOZ_NO_REMOTE': '1', 03:43:07 INFO - 'NO_EM_RESTART': '1', 03:43:07 INFO - 'PAGER': '/bin/cat', 03:43:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:07 INFO - 'PWD': '/builds/slave/test', 03:43:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:07 INFO - 'SHELL': '/bin/bash', 03:43:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqZyZYZ5YX/Listeners', 03:43:07 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:43:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:07 INFO - 'USER': 'cltbld', 03:43:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:07 INFO - 'XPC_FLAGS': '0x0', 03:43:07 INFO - 'XPC_SERVICE_NAME': '0', 03:43:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:08 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:43:08 INFO - Cleaning up... 03:43:08 INFO - Return code: 0 03:43:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:08 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 0x10a92ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a93e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb6bccdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7cde00>, '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 0x10a636db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a7c8b20>, '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.nusMLK6lIi/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.dqZyZYZ5YX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:08 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:43:08 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:43:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nusMLK6lIi/Render', 03:43:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:08 INFO - 'HOME': '/Users/cltbld', 03:43:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:08 INFO - 'LOGNAME': 'cltbld', 03:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:08 INFO - 'MOZ_NO_REMOTE': '1', 03:43:08 INFO - 'NO_EM_RESTART': '1', 03:43:08 INFO - 'PAGER': '/bin/cat', 03:43:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:08 INFO - 'PWD': '/builds/slave/test', 03:43:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:08 INFO - 'SHELL': '/bin/bash', 03:43:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqZyZYZ5YX/Listeners', 03:43:08 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:43:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:08 INFO - 'USER': 'cltbld', 03:43:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:08 INFO - 'XPC_FLAGS': '0x0', 03:43:08 INFO - 'XPC_SERVICE_NAME': '0', 03:43:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:08 INFO - Downloading/unpacking psutil>=0.7.1 03:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:43:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:11 INFO - Installing collected packages: psutil 03:43:11 INFO - Running setup.py install for psutil 03:43:11 INFO - building 'psutil._psutil_osx' extension 03:43:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:43:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:43:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:43:11 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:11 INFO - building 'psutil._psutil_posix' extension 03:43:11 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:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:43:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:43:12 INFO - ^ 03:43:12 INFO - 1 warning generated. 03:43:12 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:43:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:12 INFO - Successfully installed psutil 03:43:12 INFO - Cleaning up... 03:43:12 INFO - Return code: 0 03:43:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a92ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a93e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb6bccdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7cde00>, '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 0x10a636db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a7c8b20>, '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.nusMLK6lIi/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.dqZyZYZ5YX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:43:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nusMLK6lIi/Render', 03:43:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:12 INFO - 'HOME': '/Users/cltbld', 03:43:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:12 INFO - 'LOGNAME': 'cltbld', 03:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:12 INFO - 'MOZ_NO_REMOTE': '1', 03:43:12 INFO - 'NO_EM_RESTART': '1', 03:43:12 INFO - 'PAGER': '/bin/cat', 03:43:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:12 INFO - 'PWD': '/builds/slave/test', 03:43:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:12 INFO - 'SHELL': '/bin/bash', 03:43:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqZyZYZ5YX/Listeners', 03:43:12 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:43:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:12 INFO - 'USER': 'cltbld', 03:43:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:12 INFO - 'XPC_FLAGS': '0x0', 03:43:12 INFO - 'XPC_SERVICE_NAME': '0', 03:43:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:43:15 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:15 INFO - Installing collected packages: mozsystemmonitor 03:43:15 INFO - Running setup.py install for mozsystemmonitor 03:43:15 INFO - Successfully installed mozsystemmonitor 03:43:15 INFO - Cleaning up... 03:43:15 INFO - Return code: 0 03:43:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a92ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a93e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb6bccdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7cde00>, '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 0x10a636db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a7c8b20>, '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.nusMLK6lIi/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.dqZyZYZ5YX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:43:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nusMLK6lIi/Render', 03:43:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:15 INFO - 'HOME': '/Users/cltbld', 03:43:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:15 INFO - 'LOGNAME': 'cltbld', 03:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:15 INFO - 'MOZ_NO_REMOTE': '1', 03:43:15 INFO - 'NO_EM_RESTART': '1', 03:43:15 INFO - 'PAGER': '/bin/cat', 03:43:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:15 INFO - 'PWD': '/builds/slave/test', 03:43:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:15 INFO - 'SHELL': '/bin/bash', 03:43:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqZyZYZ5YX/Listeners', 03:43:15 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:43:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:15 INFO - 'USER': 'cltbld', 03:43:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:15 INFO - 'XPC_FLAGS': '0x0', 03:43:15 INFO - 'XPC_SERVICE_NAME': '0', 03:43:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:15 INFO - Downloading/unpacking blobuploader==1.2.4 03:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:17 INFO - Downloading blobuploader-1.2.4.tar.gz 03:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:43:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:43:17 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:17 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:17 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:17 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:17 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:17 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 - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:43:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:18 INFO - Downloading docopt-0.6.1.tar.gz 03:43:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:43:19 INFO - Installing collected packages: blobuploader, requests, docopt 03:43:19 INFO - Running setup.py install for blobuploader 03:43:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:43:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:43:19 INFO - Running setup.py install for requests 03:43:19 INFO - Running setup.py install for docopt 03:43:19 INFO - Successfully installed blobuploader requests docopt 03:43:19 INFO - Cleaning up... 03:43:20 INFO - Return code: 0 03:43:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:20 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:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:20 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:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:20 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 0x10a92ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a93e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb6bccdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7cde00>, '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 0x10a636db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a7c8b20>, '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.nusMLK6lIi/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.dqZyZYZ5YX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:20 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:20 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:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nusMLK6lIi/Render', 03:43:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:20 INFO - 'HOME': '/Users/cltbld', 03:43:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:20 INFO - 'LOGNAME': 'cltbld', 03:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:20 INFO - 'MOZ_NO_REMOTE': '1', 03:43:20 INFO - 'NO_EM_RESTART': '1', 03:43:20 INFO - 'PAGER': '/bin/cat', 03:43:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:20 INFO - 'PWD': '/builds/slave/test', 03:43:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:20 INFO - 'SHELL': '/bin/bash', 03:43:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqZyZYZ5YX/Listeners', 03:43:20 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:43:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:20 INFO - 'USER': 'cltbld', 03:43:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:20 INFO - 'XPC_FLAGS': '0x0', 03:43:20 INFO - 'XPC_SERVICE_NAME': '0', 03:43:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:43:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-gkoAHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:43:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-OIuFIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-qJc6NH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-xFtC92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-BDorcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-cUN8jH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:43:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-j4KN85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:43:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-4yoax4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:43:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-eARAqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:43:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-qB9n7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:43:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-B7xPEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:43:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-oinloH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:43:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-xAdPWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:43:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-vjq0KB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-c3qQFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:43:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-a2H1Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:43:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Lknten-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:43:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:43:22 INFO - Running setup.py install for manifestparser 03:43:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:43:22 INFO - Running setup.py install for mozcrash 03:43:22 INFO - Running setup.py install for mozdebug 03:43:22 INFO - Running setup.py install for mozdevice 03:43:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:43:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:43:22 INFO - Running setup.py install for mozfile 03:43:22 INFO - Running setup.py install for mozhttpd 03:43:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:43:22 INFO - Running setup.py install for mozinfo 03:43:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:43:23 INFO - Running setup.py install for mozInstall 03:43:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:43:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:43:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:43:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:43:23 INFO - Running setup.py install for mozleak 03:43:23 INFO - Running setup.py install for mozlog 03:43:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:43:23 INFO - Running setup.py install for moznetwork 03:43:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:43:23 INFO - Running setup.py install for mozprocess 03:43:23 INFO - Running setup.py install for mozprofile 03:43:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:43:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:43:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:43:23 INFO - Running setup.py install for mozrunner 03:43:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:43:24 INFO - Running setup.py install for mozscreenshot 03:43:24 INFO - Running setup.py install for moztest 03:43:24 INFO - Running setup.py install for mozversion 03:43:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:43:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:43:24 INFO - Cleaning up... 03:43:24 INFO - Return code: 0 03:43:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:24 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 0x10a92ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a93e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb6bccdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7cde00>, '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 0x10a636db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a7c8b20>, '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.nusMLK6lIi/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.dqZyZYZ5YX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:24 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:24 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:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nusMLK6lIi/Render', 03:43:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:24 INFO - 'HOME': '/Users/cltbld', 03:43:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:24 INFO - 'LOGNAME': 'cltbld', 03:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:24 INFO - 'MOZ_NO_REMOTE': '1', 03:43:24 INFO - 'NO_EM_RESTART': '1', 03:43:24 INFO - 'PAGER': '/bin/cat', 03:43:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:24 INFO - 'PWD': '/builds/slave/test', 03:43:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:24 INFO - 'SHELL': '/bin/bash', 03:43:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqZyZYZ5YX/Listeners', 03:43:24 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:43:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:24 INFO - 'USER': 'cltbld', 03:43:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:24 INFO - 'XPC_FLAGS': '0x0', 03:43:24 INFO - 'XPC_SERVICE_NAME': '0', 03:43:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:43:24 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-VPmpTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:43:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:43:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-v1tDaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-UB3Ofe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-sV0bjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-WwQ4Hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-NQh59L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:43:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:43:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-GR31le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:43:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:43:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-pwb6wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:43:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:43:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-pnozIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:43:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:43:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-FDvPxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:43:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:43:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-MBix_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:43:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:43:26 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-gpP6q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:43:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:43:26 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-dwys12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:43:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:43:26 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-H9yvX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:43:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:26 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-zckEdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:43:26 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-fNqrWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:43:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:43:26 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-wFskjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:43:26 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:26 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:26 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:26 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:26 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:26 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:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:43:26 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:26 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:26 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:26 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:26 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:26 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 blessings-1.6.tar.gz 03:43:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:43:29 INFO - Installing collected packages: blessings 03:43:29 INFO - Running setup.py install for blessings 03:43:29 INFO - Successfully installed blessings 03:43:29 INFO - Cleaning up... 03:43:29 INFO - Return code: 0 03:43:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 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 - Current package versions: 03:43:30 INFO - blessings == 1.6 03:43:30 INFO - blobuploader == 1.2.4 03:43:30 INFO - docopt == 0.6.1 03:43:30 INFO - manifestparser == 1.1 03:43:30 INFO - mozInstall == 1.12 03:43:30 INFO - mozcrash == 0.17 03:43:30 INFO - mozdebug == 0.1 03:43:30 INFO - mozdevice == 0.48 03:43:30 INFO - mozfile == 1.2 03:43:30 INFO - mozhttpd == 0.7 03:43:30 INFO - mozinfo == 0.9 03:43:30 INFO - mozleak == 0.1 03:43:30 INFO - mozlog == 3.1 03:43:30 INFO - moznetwork == 0.27 03:43:30 INFO - mozprocess == 0.22 03:43:30 INFO - mozprofile == 0.28 03:43:30 INFO - mozrunner == 6.11 03:43:30 INFO - mozscreenshot == 0.1 03:43:30 INFO - mozsystemmonitor == 0.0 03:43:30 INFO - moztest == 0.7 03:43:30 INFO - mozversion == 1.4 03:43:30 INFO - psutil == 3.1.1 03:43:30 INFO - requests == 1.2.3 03:43:30 INFO - wsgiref == 0.1.2 03:43:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:30 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:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:30 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:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:30 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 0x10a92ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a93e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb6bccdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7cde00>, '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 0x10a636db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a7c8b20>, '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.nusMLK6lIi/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.dqZyZYZ5YX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:30 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:30 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:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nusMLK6lIi/Render', 03:43:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:30 INFO - 'HOME': '/Users/cltbld', 03:43:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:30 INFO - 'LOGNAME': 'cltbld', 03:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:30 INFO - 'MOZ_NO_REMOTE': '1', 03:43:30 INFO - 'NO_EM_RESTART': '1', 03:43:30 INFO - 'PAGER': '/bin/cat', 03:43:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:30 INFO - 'PWD': '/builds/slave/test', 03:43:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:30 INFO - 'SHELL': '/bin/bash', 03:43:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqZyZYZ5YX/Listeners', 03:43:30 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:43:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:30 INFO - 'USER': 'cltbld', 03:43:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:30 INFO - 'XPC_FLAGS': '0x0', 03:43:30 INFO - 'XPC_SERVICE_NAME': '0', 03:43:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 INFO - Cleaning up... 03:43:30 INFO - Return code: 0 03:43:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:43:30 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:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:30 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:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:30 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 0x10a92ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a93e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb6bccdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7cde00>, '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 0x10a636db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a7c8b20>, '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.nusMLK6lIi/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.dqZyZYZ5YX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:30 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:30 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:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nusMLK6lIi/Render', 03:43:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:30 INFO - 'HOME': '/Users/cltbld', 03:43:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:30 INFO - 'LOGNAME': 'cltbld', 03:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:30 INFO - 'MOZ_NO_REMOTE': '1', 03:43:30 INFO - 'NO_EM_RESTART': '1', 03:43:30 INFO - 'PAGER': '/bin/cat', 03:43:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:30 INFO - 'PWD': '/builds/slave/test', 03:43:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:30 INFO - 'SHELL': '/bin/bash', 03:43:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqZyZYZ5YX/Listeners', 03:43:30 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:43:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:30 INFO - 'USER': 'cltbld', 03:43:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:30 INFO - 'XPC_FLAGS': '0x0', 03:43:30 INFO - 'XPC_SERVICE_NAME': '0', 03:43:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:30 INFO - Downloading/unpacking jsonschema 03:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:43:33 INFO - Downloading/unpacking functools32 (from jsonschema) 03:43:33 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:33 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:33 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:33 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:33 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:33 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:33 INFO - Downloading functools32-3.2.3-2.tar.gz 03:43:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:43:33 INFO - warning: no files found matching '*.txt' 03:43:33 INFO - no previously-included directories found matching 'build' 03:43:33 INFO - no previously-included directories found matching 'dist' 03:43:33 INFO - no previously-included directories found matching '.git*' 03:43:33 INFO - Installing collected packages: jsonschema, functools32 03:43:33 INFO - Running setup.py install for functools32 03:43:34 INFO - warning: no files found matching '*.txt' 03:43:34 INFO - no previously-included directories found matching 'build' 03:43:34 INFO - no previously-included directories found matching 'dist' 03:43:34 INFO - no previously-included directories found matching '.git*' 03:43:34 INFO - Successfully installed jsonschema functools32 03:43:34 INFO - Cleaning up... 03:43:34 INFO - Return code: 0 03:43:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a92ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a93e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb6bccdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7cde00>, '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 0x10a636db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a7c8b20>, '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.nusMLK6lIi/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.dqZyZYZ5YX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:43:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:43:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nusMLK6lIi/Render', 03:43:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:34 INFO - 'HOME': '/Users/cltbld', 03:43:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:34 INFO - 'LOGNAME': 'cltbld', 03:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:34 INFO - 'MOZ_NO_REMOTE': '1', 03:43:34 INFO - 'NO_EM_RESTART': '1', 03:43:34 INFO - 'PAGER': '/bin/cat', 03:43:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:34 INFO - 'PWD': '/builds/slave/test', 03:43:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:34 INFO - 'SHELL': '/bin/bash', 03:43:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqZyZYZ5YX/Listeners', 03:43:34 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:43:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:34 INFO - 'USER': 'cltbld', 03:43:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:34 INFO - 'XPC_FLAGS': '0x0', 03:43:34 INFO - 'XPC_SERVICE_NAME': '0', 03:43:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:34 INFO - Downloading/unpacking flake8 03:43:34 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:34 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:34 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:34 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:34 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:34 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:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:43:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:43:36 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:36 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:36 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:36 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:36 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:36 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:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:43:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:43:37 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:37 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:37 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:37 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:37 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:37 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:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:43:37 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:37 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:37 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:37 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:37 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:37 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:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:43:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:43:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:43:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:43:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:43:38 INFO - no previously-included directories found matching 'docs/_build' 03:43:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:43:38 INFO - Running setup.py install for pep8 03:43:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:43:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:43:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:43:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:43:38 INFO - no previously-included directories found matching 'docs/_build' 03:43:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:43:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:43:38 INFO - Cleaning up... 03:43:38 INFO - Return code: 0 03:43:38 INFO - Running post-action listener: _resource_record_post_action 03:43:38 INFO - Running post-action listener: _start_resource_monitoring 03:43:38 INFO - Starting resource monitoring. 03:43:38 INFO - ##### 03:43:38 INFO - ##### Running install step. 03:43:38 INFO - ##### 03:43:38 INFO - Running pre-action listener: _resource_record_pre_action 03:43:38 INFO - Running main action method: install 03:43:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:43:38 INFO - Reading from file tmpfile_stdout 03:43:38 INFO - Detecting whether we're running mozinstall >=1.0... 03:43:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:43:38 INFO - Reading from file tmpfile_stdout 03:43:38 INFO - Output received: 03:43:38 INFO - Usage: mozinstall [options] installer 03:43:38 INFO - Options: 03:43:38 INFO - -h, --help show this help message and exit 03:43:38 INFO - -d DEST, --destination=DEST 03:43:38 INFO - Directory to install application into. [default: 03:43:38 INFO - "/builds/slave/test"] 03:43:38 INFO - --app=APP Application being installed. [default: firefox] 03:43:38 INFO - mkdir: /builds/slave/test/build/application 03:43:38 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:38 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:11 INFO - Reading from file tmpfile_stdout 03:44:11 INFO - Output received: 03:44:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:44:11 INFO - Running post-action listener: _resource_record_post_action 03:44:11 INFO - ##### 03:44:11 INFO - ##### Running run-tests step. 03:44:11 INFO - ##### 03:44:11 INFO - Running pre-action listener: _resource_record_pre_action 03:44:11 INFO - Running main action method: run_tests 03:44:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:44:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:44:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:44:11 INFO - 2016-04-23 03:44:11.969 screenresolution[1641:7623] starting screenresolution argv=screenresolution get 03:44:11 INFO - 2016-04-23 03:44:11.971 screenresolution[1641:7623] Display 0: 1600x1200x32@60 03:44:11 INFO - 2016-04-23 03:44:11.977 screenresolution[1642:7625] starting screenresolution argv=screenresolution list 03:44:11 INFO - Available Modes on Display 0 03:44:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:44:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:44:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:44:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:44:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:44:12 INFO - Intel Iris: 03:44:12 INFO - Chipset Model: Intel Iris 03:44:12 INFO - Type: GPU 03:44:12 INFO - Bus: Built-In 03:44:12 INFO - VRAM (Dynamic, Max): 1536 MB 03:44:12 INFO - Vendor: Intel (0x8086) 03:44:12 INFO - Device ID: 0x0a2e 03:44:12 INFO - Revision ID: 0x0009 03:44:12 INFO - Displays: 03:44:12 INFO - Display: 03:44:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:44:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:44:12 INFO - Display Serial Number: 1600x1200 60 03:44:12 INFO - Main Display: Yes 03:44:12 INFO - Mirror: Off 03:44:12 INFO - Online: Yes 03:44:12 INFO - Rotation: Supported 03:44:12 INFO - Return code: 0 03:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:44:12 INFO - Python 2.7.3 03:44:12 INFO - Return code: 0 03:44:12 INFO - grabbing minidump binary from tooltool 03:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:12 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 0x10a7cde00>, '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 0x10a636db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a7c8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:44:12 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:12 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:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:44:12 INFO - Return code: 0 03:44:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:44:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:44:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:44:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:44:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:44:13 INFO - Return code: 0 03:44:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0112 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:44:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nusMLK6lIi/Render', 03:44:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:13 INFO - 'HOME': '/Users/cltbld', 03:44:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:13 INFO - 'LOGNAME': 'cltbld', 03:44:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:13 INFO - 'MOZ_NO_REMOTE': '1', 03:44:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:13 INFO - 'NO_EM_RESTART': '1', 03:44:13 INFO - 'PAGER': '/bin/cat', 03:44:13 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:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:13 INFO - 'PWD': '/builds/slave/test', 03:44:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:13 INFO - 'SHELL': '/bin/bash', 03:44:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqZyZYZ5YX/Listeners', 03:44:13 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:44:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:13 INFO - 'USER': 'cltbld', 03:44:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:13 INFO - 'XPC_FLAGS': '0x0', 03:44:13 INFO - 'XPC_SERVICE_NAME': '0', 03:44:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:44:13 INFO - mozversion application_buildid: 20160423014751 03:44:13 INFO - mozversion application_changeset: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 03:44:13 INFO - mozversion application_display_name: Nightly 03:44:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:44:13 INFO - mozversion application_name: Firefox 03:44:13 INFO - mozversion application_remotingname: firefox 03:44:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:44:13 INFO - mozversion application_vendor: Mozilla 03:44:13 INFO - mozversion application_version: 48.0a1 03:44:13 INFO - mozversion platform_buildid: 20160423014751 03:44:13 INFO - mozversion platform_changeset: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 03:44:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:44:13 INFO - mozversion platform_version: 48.0a1 03:44:13 INFO - using testdate: 1461408253 03:44:13 INFO - actual date: 1461408253 03:44:13 INFO - starting webserver on 'localhost:49270' 03:44:13 INFO - SUITE-START | Running 2 tests 03:44:13 INFO - TEST-START | dromaeo_css 03:44:13 INFO - operating with platform_type : mac_ 03:44:13 INFO - Initialising browser for dromaeo_css test... 03:44:13 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpGyVALV/profile http://localhost:49270/getInfo.html) 03:44:16 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 03:44:16 INFO - PROCESS | 1660 | colorDepth:24 03:44:16 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 03:44:16 INFO - PROCESS | 1660 | __metrics 03:44:16 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:44:17 INFO - TEST-INFO | 1660: exit 0 03:44:17 INFO - Browser initialized. 03:44:17 INFO - Running cycle 1/1 for dromaeo_css test... 03:44:17 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpGyVALV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:29 INFO - PROCESS | 1663 | RSS: Main: 249675776 03:44:29 INFO - PROCESS | 1663 | 03:45:19 INFO - PROCESS | 1663 | 1461408319059 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:29 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 03:47:31 INFO - PROCESS | 1663 | RSS: Main: 261566464 03:47:31 INFO - PROCESS | 1663 | 03:50:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 03:50:33 INFO - PROCESS | 1663 | RSS: Main: 273387520 03:50:33 INFO - PROCESS | 1663 | 03:53:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 03:53:36 INFO - PROCESS | 1663 | RSS: Main: 275292160 03:53:36 INFO - PROCESS | 1663 | 03:56:38 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 03:56:38 INFO - PROCESS | 1663 | RSS: Main: 276992000 03:56:38 INFO - PROCESS | 1663 | 03:59:41 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 03:59:42 INFO - PROCESS | 1663 | RSS: Main: 279932928 03:59:42 INFO - PROCESS | 1663 | 04:02:44 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 04:02:45 INFO - PROCESS | 1663 | RSS: Main: 281223168 04:02:45 INFO - PROCESS | 1663 | 04:02:45 INFO - PROCESS | 1663 | __start_tp_report 04:02:45 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 04:02:45 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 04:02:45 INFO - PROCESS | 1663 | |i|pagename|runs| 04:02:45 INFO - PROCESS | 1663 | |0;dojo.html;3412.112850658829;3433.313337332534;3491.5984661763905;3517.0328159756073;3525.2773181497796;5542.39033706293;5673.574481913853;5676.290463692038;5678.205051292817;5738.512226460745;5636.549076073915;5665.575081868866;5722.313322401307;5799.768009279624;5823.621464604808;5139.537441630253;5168.173092305232;5187.247849061884;5236.764345604438;5296.364436267634;5254.4220135785035;5273.1826566882;5313.070212712779;5330.466953304677;5331.493508116722;4191.790410479494;5029;5102.821401250975;5227.32044834171;5234.371875374979;5155.896882062338;5166.302549155854;5184.300119483859;5187.170052791573;5217.217417387385;5110.897782044338;5149.459306772772;5156.123459011977;5168.9224661630105;5189.273501709764;4063.5326937402283;5448.482394172547;5513.61404701671;5538.556915446755;5591.916121258144;5866.472017518444;5984.042553191512;5995.460408563206;6001.3098493672915;6013.458788709037;6117.510599152057;6121.816345509642;6121.818815678045;6133.3559976202305;6206.193194884636;5759.539236861041;5762.538996880239;5771.538276937877;5788.855278618068;5789.536837053068;6230.43926046658;6249.437550620466;6272.247330320391;6283.183186185766;6287.654179020198;5989.940100598938;6056.242969628796;6116.761878222105;6165.198524191826;6172.22847144107;5246.685198888079;6188.257409110935;6223.315435302113;6275.497960163268;6276.301190488042;5918.437748413894;5918.704064796829;6102.145699602059;6189.04069869171;6235.96882015587;6064.241969753781;6143.880361275353;6147.862645410524;6160.722767475474;6191.938080619227;4556.157110934488;4610.861674149781;4901.877453063702;4915.5330243626795;4933.58064564516;4204.62158405745;4346.2828633275785;4354.716943398669;4412.84555040572;4428.402165707653;4799.904001919942;5543.861403464945;5561.6663000219305;5705;5716.399778023331;5789.623674461147;6157.507399408037;6200.534959877937;6205.410486003822;6211.65835879022;5666.97166514173;5679.091345384719;5688.260526131577;5691.288588926384;5692.57305702074;4464.441944756905;5253.816116435983;5317.361916569959;5374.6506477078865;5425.294711687456;6287.1198032275515;6307.495400367868;6318.873622527523;6336.144620476177;6347.619142851444;6070.7875224366935;6154.323024467216;6177.84555386101;6272.278687950944;6297.055441683784;5382;6065.9081365352895;6260.937390626035;6295.307516173309;6347.873042539031;5399.325084364455;5758.733078722675;6131.60144590618;6140.048292514667;6179.84550386244;6064.363241859718;6075.210222671201;6106.236720409949;6117.938820611915;6147.170132032118;5937.732802023833;5946.732397042057;6015.458608725061;6086.513078953584;6120.325235636462;6076.270847498328;6079.756809727562;6084.117802918464;6102.572819902564;6110.083487476914;5763.221965034667;5773.624714393551;5890.087036509177;5954.166416701579;5963.493103086286;6015.2781666200335;6062.939370606414;6113.98035644981;6121.173641558511;6123.142760013513;5906.822795316148;5921.763129474945;5941.019731744386;5944.791932282349;5952.434518720715 04:02:45 INFO - PROCESS | 1663 | |1;ext.html;507.47476361965374;534.2307077807956;552.6794459213654;581.6597290585007;598.1446531460014;31450.842745786296;38385;38453.80773096134;38560.614393856056;38651;39556.01109972252;40099.79700608979;40209.79895100528;40258;40481;9476.44136083257;9696.709098727015;9735.51322433879;9751.463669498175;9753.561089750978;9554.570044347985;9667.033296670346;9678.564464599074;9695.03049695032;9703.320767546275;8611.181937715906;9649.517524123801;9710.805783884318;9748.658796942109;9761.951190244039;8185.8362832743305;8406.537640429804;9689.90310096897;9717.31978761487;9768.413895166243;9584.137427631547;9678;9679;9714;9721.951390243074;32195.034148975566;38624.61375386238;38858.22283554341;38866.61133388658;39093;2966.7033296670375;2985.208919636298;3117.1427857339413;3243.96756032439;3436.7250619950346;27833.16500504988;28226;29359.55960660592;30131.849340753375;30919;2659.853708046076;2730.0990673077836;2740.397112635237;2743.3141714571357;2772.514809908258;284732.576337117;314422.99999999773;316632;341741;346346;35768.46347304792;51630.48369516332;59250.25997920156;62667;62787.05819412712;30125.548116778267;32524;35482.46776298358;35628.10929726777;35793.92618221458;15049;15198.544043678707;15237.466688666065;15270.770938435933;15321.693566128615;12871.292078935561;12895.742085158245;12898.742025159632;12899.613011609667;12916.547920822726;7654.464187506821;7733.690652373842;8126.471779334324;8290.336773058141;8457.703980360659;3106.701041229474;3320.269540701042;3417.79493230407;3492.633273506245;3495.3184129094584;988.5699720621552;996.7408473796866;1085.8642669666292;1116.4808364110727;1134.6085600467825;30074;30097.60656507833;30338.241543961576;30645.540316895265;30714.53928191079;914.1909410172045;1054.2409465185056;1063.276971659279;1125.0549538387793;1159.287038471334;15387.692246155015;15419.460318888785;15737.370505179893;15966.36134554628;16360.018398896103;637205;651940.7402962955;652367;653518.732406335;656967;59445.70277148673;59558.10662840061;60024.39975600188;60110.699446503364;60274;1459.868611824941;1483.7403454395437;1502.188818038247;1503.0230350272411;1503.6015455904194;28854.278643034093;29155.271118222216;29226.56160157557;29737.851310743306;29753.85123074371;54924.45075549193;55325;55708.72145639246;55887.44112558822;55963.160552592555;578663;602840;603244;603314;603639;27410;27648.170554883385;27857.44285114246;27928.720712792612;27956.44087118287;45626.54373456356;45766.62700119002;46554;46799;46945.765271173426;36324.91025269246;36330.455043173846;36465.81767091148;37131.628683712814;37243;31486.842565787025;31897.521537176497;32224.35551289008;33833;36280.27439451249;33901.32197356089;37531;38033;38320.80839595784;38433.615663844124;30269.394612108073;31403.528947065355;31467.68532314739;31501.684983149877;31519.68480315259;23883.64174537418;24593.50812983766;24723.87638061798;25057.87471062633;25276.368090797878 04:02:45 INFO - PROCESS | 1663 | |2;jquery.html;391.0048925484642;391.81388840300843;394.2312490643246;396.423204237834;405.76262886211566;20025.699614505775;20296.8985155074;20790.688139677917;20848.374548763542;21285.893570532164;19999.700004499908;20160.59678806423;21931.903404829736;22077.227297044607;22212.77787222127;5026.220935754964;5384.542313903323;5390.811321603745;5392.811251606195;5396.406395296514;5340.91988620171;5413.133898576229;5653.547716182696;6069.878602427949;6081.087836824468;5762.164486149506;6015.789447369321;6054.727537260812;6056.666883321415;6074.210352654149;5239.633225674204;5991.460768530831;6065.150878876961;6125.295591007047;6150.384961503859;5701.942980570224;5935.851603709899;5984.8503787405225;5995.6702381369005;6001.639901605874;12598.181118227287;13441.731165376637;13801.654958626013;13969;14017.088889222168;2015.6573382525005;2093.5184907471216;2196.967045494319;2457.348802567321;2462.778349948513;8042.235987581171;8170.264676179172;9700.078492543196;10123.79752404955;10332.276740628158;1641.917904104802;1668.099226417745;1671.264643556831;1716.4078392954411;1740.0718077578272;117382;122475;122871.77128228692;124949.37525312406;124970;11752.647420577225;11910.404479775976;11911.583094591648;11941.58204462857;12006.699832504257;15227.619309517351;15280.31238594266;15299.929004969545;15321.080735155927;15339.61650958735;7254.637268136572;7387.963060184665;8523.82952340962;8937.46375217476;8980.550972451481;8828.8675669865;8865.024847266795;8868.423552469068;8914.55427228636;8933.704612831103;3845.9615403846165;4599.310103484504;4681.7190968542;4719.457262414798;4753.405824271966;1939.544719492474;1993.6311782320026;2019.9394018179478;2021.8382529397613;2069.906854191565;904.1500989070253;958.3100167879115;998.1366118307757;1011.5953618552638;1025.0876719719456;19049.523761906064;19911.701324480146;20236.797632023492;20453.48866278355;20485.897570512054;947.6588428165993;949.9192568631605;991.3407583956732;999.5651891427252;1013.3109485549896;10633.096186824207;10715.981981711724;10735.677929662123;10743.731406714895;10781.730456738487;592412;597573;605715;615279;616802;92100;115038.84961150448;119666.40166799285;122619.77380226261;129159;968.8595153702673;996.2976101848179;1068.278911734576;1069.983950240747;1075.102289588187;18303.54241143982;18584.535386615444;18633.068346582346;18713.812861871207;18739.250429982647;48063.75968120137;48435.51564484451;50175.99999999854;51045;51535.742321288155;70908.45492704336;72425;72548;72993.27006730078;73389.26610733825;6691.966540167268;7966.522008679498;8034.718784842503;8104.554249516097;8474.872876906975;10596.470176491299;11405.775873704548;12208.389580521116;12514.12401131912;12671.17637353569;10815.56737730482;10869.565217391215;10891.346519208873;11180.217384782987;11202.047825934887;9417.775689160366;9992.350497217658;10696;10710.946445267724;10880.945595271973;10521.329377446398;10797.136229101496;10923.18779354396;11083.667489975314;11085.612003579836;8009.3192078673965;8152.266296033148;8170.10128885834;8196.426250162669;8340.582970851554;10007.799844003224;10895.945520272666;11177.88822111801;11230.719232019264;11243.887561124611 04:02:45 INFO - PROCESS | 1663 | |3;mootools.html;1335.205552696146;1628.8615467685242;1795.1293622593041;1807.5119717676228;1984.394759598322;7930.246626570473;7975.680972761083;8615.224629783319;8631.611577479012;8896.02143764187;8721.040685524587;8726.52004139772;8800.867986980184;8808.515531645757;8848.42485238459;2465.778079972802;2487.9253622391357;2488.129154795825;2492.028109037468;2497.0386401235564;2445.8532488050687;2508.159766478232;2517.7104632967166;2519.2945975126904;2519.6346529753173;2499.262717498333;2503.4993001399703;2527.279725278296;2528.5954247320433;2542.4533725249066;2464.371585245769;2467.9506409871883;2481.7146028206807;2491.476789874129;2493.8004959603277;2450.901963921441;2462.9014839406404;2470.715867675204;2481.6401621764744;2487.0300582772734;8899.688510902151;8908.955455222747;8919.866202006975;8952.418092824011;8969.461832290019;5248.21276808478;5534.142207957732;5536.861578460531;5547.44525547446;5589.776408943638;3542.2738338640515;3572.4819901114192;3578.141246100943;3603.657652523006;3604.945925811115;1023.7696518283401;1039.4646756920192;1039.501039501036;1055.0399136785566;1055.757175849559;11565.653030409017;11655.825162622568;11688.240264382788;11698.415079246004;11721.824172637333;4102.5692302307825;4212.515560710496;4759.4764575896625;4853.3447984522345;4988.351514303117;8654.437461564978;9928.900710992943;10075.445850478294;10089.899101009043;10110.24173187014;5388.326459192601;5464.3442786865035;5464.7814087436855;5478.972605136949;5505.944940550623;4444.355568442557;4457.621102206284;4815.686980346266;4955.603551715854;4988.725620090857;4117.814698338582;4130.132672138884;4142.032534546067;4146.979265103715;4148.108156746314;1299.512682743971;1341.148370784559;1356.0643156222175;1389.7290028444559;1403.4947418929178;915.5834095486538;935.7005758157325;943.3208090175063;950.6720181537358;970.8203982263304;6027.547933904974;6080.179175811209;6090.786822461193;6144.446999770043;6181.629102253879;465.24165610055394;475.3772557949098;484.5348465473115;488.38707422184933;488.655497873998;3695.8706445274825;4021.7989100544855;4093.733907296076;4169.353750168729;4178.937315940263;10444.529996150191;10870.72823179411;10893;10906.400147991937;10922.672319830417;10495.527701253463;10604.681859544226;10632.734181645366;10811.081058110149;10855.511501982272;6237.500999919996;8079.111297757242;8242.340612750966;8314.168583141638;8377.664893404317;5991.7902873399225;6032.758689652364;6127.264728232462;6194.659293738708;6200.255969283715;8268.875966860382;9636.277279203947;9673.854892176481;9914.900850991398;9934.304598678023;9710.271729620166;9713;9980.001999799963;10034.19726421899;10140.645077422254;6633.867322653424;6875.5530890491955;7017.859642807218;7234.74678386254;7287.125544934642;8366.288865446506;8409.159084091787;8462.365322600706;8472.830543388975;8477.109903460294;7320.597367144858;7352.48532602734;7487.363574096263;7556;7622.970898928796;6850;7057.400120989568;7095.361417472453;7098.112735908012;7109.680064397218;7028.016077749221;7111;7130.073090498202;7146.749863754952;7185.317394847481;4693.155232058262;4833.3958255218095;4978.4025916890205;5008.398992120969;5251.949610078076;4766.998930224691;4990.5508504234795;5060.519250671327;5119.334486516729;5321.600879934098 04:02:45 INFO - PROCESS | 1663 | |4;prototype.html;318.77367069380745;322.79986408426777;328.8602344003798;329.3741890408225;333.18203809647287;6087.11736798164;6210.254769427664;6290.21372328459;6293.27627322858;6301.117843501907;6061.090836374535;6087.78692745754;6151.4463698267145;6154.5999510031925;6210.844728881781;3667.559892812853;4354.3250796126495;4605.332226827108;4633.62930965522;4638.8608341749805;4501.864944051684;4598.563136502027;4606.101810147023;4627.190241707688;4645.88385290367;4573.451185857685;4582.221022426195;4588.655850811202;4610.838620648261;4631.9536804632025;4208.326667733163;4516.345129956171;4525.004499010212;4529;4532;3217.758668099902;3466.757326987112;3824.9235015299814;3853.402722578005;3863.5363756349416;5159.277701121846;5623.622212557909;5903.409659034105;5909.734061967179;5951.345352011275;5011.874703132415;5173.456787037345;5179.326687530634;5193.065248255312;5248.160294352885;5332.3867755207875;6376.872462550769;6432.260290066609;6450.225972883284;6457.93542064578;3224.339010502841;3873.922521549553;4139.257664553683;4254.617084462413;4275.807588658487;5632.74652640628;6014.669193194372;6678.395425783948;6903.654817259167;6904.447644188504;4313.266744653416;4313.956860431418;4334.566543345641;4347.130573885235;4358.65130789536;3745.1573395985683;3799.601041890617;3816.2558301131567;4067.6745860331102;4451.399061126771;4881.9511804881495;5116.795328186831;5179.249008893765;5214.530692237641;5257.053730328577;5561.971035358471;5667.09326507765;5734.627249228787;5873.177755114288;6447.967760161263;1399.7900314952838;1419.8438171801095;1522.956774609396;1524.215029259932;1529.908205507673;920.769807548113;959.7168835193635;983.9950800245953;985.0986347492108;987.9160271377013;5185.611079169077;5307.6019298552765;5575.944240557624;6005.969970150121;6047.879042419127;5530.695811730313;6730.32696730323;6777.186737591521;6781;6820.35206655367;5688.866674996876;6092.664903430265;6111.724972376253;6133.29467111279;6139.447449729457;2951.719586639266;3052.016189476858;3271.672832716757;3576.3741345264475;3632.2735452909524;6735.29279425663;6844.555103918229;7092.255313192144;7167.569945803269;7196.617589732818;7012;7065.788026359218;7089.291070892869;7097.338498063226;7098.39663628587;5636;6689.632070236086;6836.863262734718;6917.481188910952;7144.857102858018;5431.619786614899;6469.547131700736;6895.276365835367;6916.619585922823;6933.757318493828;6292.402221788922;6367.076773867856;6621.702023408862;6749.9662501689145;6801.9319806801295;5677.829665110054;6668.966310221924;7153.320434558708;7181.964090179516;7188.8921666174;3829.961700383072;3929.135590170158;4358.869233922987;4370.868873933787;4399.230134726474;6015.578909476295;6758.749631318222;6813.4889883257965;6814.727410903508;6824.18109826824;6578.5395022347975;6631.1379520662;6639.6680165992475;6662.83342916431;6683.398494135551;5507.449255074621;6315.778947736807;6545.509086818603;6594.406503414716;6615.636140012345;4955.45489996093;6225.62646241227;6398.48812095022;6422.9036564450635;6512.218533775977;5256.553192978639;5494.5054945055135;6042.939570604238;6595.142631458071;6635.535512514078;5875.294964604104;6030.638161710312;6046.395360463918;6066.786642671572;6448.290688024407 04:02:45 INFO - PROCESS | 1663 | |5;yui.html;668.8561959178776;730.2952650692088;732.5311800447711;762.0740799928086;786;14872.33074511647;14967.775483367745;15013.849861501381;15154.772678409832;15163.241837908115;13490.392932318045;14058;14095.78856317156;14096.224707641075;14108;741.2143128284009;909.958097977815;922.2483675804198;929.8419268724333;942.3686130292721;888.6489836514573;902.4134312696734;934.1592566689999;940.666063547441;940.8165407745493;968.109339407743;987.5802783816849;990.044606954289;991.6479649724353;994.0705440413201;976.1312431935547;978.7846673731767;985.0395864032582;987.1806400687412;989.4805227255677;711.5730561663013;738.4166508458311;741.9591922444317;741.9703211871519;748.1022772672815;13471.66320841977;14276.928615356961;14946.953713240078;15196.696066078617;15267.465638702703;9286.860697089549;12901.225926444444;12992.41534130957;13240.006999475077;13294.202347859062;10108.241881858816;10115.443650599214;10352.327098738559;10467.162626989822;10632.149428045737;3502.4571191465366;3543.875964341236;3557.6975957043683;3626.1478552540398;3642.8360723767496;90085;91047.08952910452;91168;92359.07640923571;92662.53668731681;9549.331546791658;9577.138057574852;9752.804943901083;9810.31327807061;9930.30487865857;22508.887455562945;22659.660105098435;22884;22906.427339316317;22956.540869182856;7526;7580.924190758022;7706.5761383123345;7723.65243564041;7751.302382785577;4101.89745256365;4106.281400754856;4121.855735049259;4126.381042843597;4150.398192262105;3548.449990251515;3594.9101272467874;3604.5494313210847;3617.312710585033;3639.526861507987;623.329920335641;635.7361694896658;659.960402375859;681.1315572644918;694.1808665774333;506.94049436676784;535.4351159526659;572.6936089192262;576.6338375131821;584.9005669036274;7052.4484613384975;7935.166807485246;8073.394495412867;8136;8173.3244684839465;469.9271612900006;487.8487668822676;507.17417297727883;513.2224679610393;513.8515418040677;3784.1863999239745;3843.5964223756664;3849.9615003850163;3867.9226415472094;3868.1296708240984;76857;77853.2479670527;79681.60159199283;80074;94363;52866.47133528616;73983.63008184925;74743.62628186824;74823.62588187025;74870.25129748741;40841.36634534645;52406.21390679143;59927.40072599305;65617;67114;6978.232394436709;7265.200827909031;8023.438359315025;8057.476264042818;8165.469244499089;43856.90357741082;43983;44228;44771;45309;63429.68285158544;67458;67589.32410676026;67671.3232867665;67783.98324025045;10765.192610554082;10983.61557345489;11068.944655276671;11279.32324060559;11299.830502542303;10410.947945260225;11781;12034.578789742667;12442.75114497723;12454.190477618926;11313.886861131612;11365.54537818478;11610.129240306842;11743.823842642538;11873.881261187278;11298.49156787963;11353.54585816558;11418.657440276806;11898.821517677416;11933;11329.773404532029;11480.827787583026;11613.070954323803;11702.239354441934;11775.175737698279;9461.716148515556;9477.715668529956;9761.511924403609;9971.102600765966;10138.79722405533;9403.153716165578;9504.809903801746;9504.85742713846;9539.23686105096;9637.22902167839 04:02:45 INFO - PROCESS | 1663 | __end_tp_report 04:02:45 INFO - PROCESS | 1663 | __start_cc_report 04:02:45 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,416 04:02:45 INFO - PROCESS | 1663 | __end_cc_report 04:02:45 INFO - PROCESS | 1663 | __startTimestamp1461409365170__endTimestamp 04:02:45 INFO - PROCESS | 1663 | 04:02:45 INFO - PROCESS | 1663 | ------- Summary: start ------- 04:02:45 INFO - PROCESS | 1663 | Number of tests: 6 04:02:45 INFO - PROCESS | 1663 | 04:02:45 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5653.90 Median:5866.47 stddev:646.45 (11.0%) stddev-sans-first:624.05 04:02:45 INFO - PROCESS | 1663 | Values: 3412.1 3433.3 3491.6 3517.0 3525.3 5542.4 5673.6 5676.3 5678.2 5738.5 5636.5 5665.6 5722.3 5799.8 5823.6 5139.5 5168.2 5187.2 5236.8 5296.4 5254.4 5273.2 5313.1 5330.5 5331.5 4191.8 5029.0 5102.8 5227.3 5234.4 5155.9 5166.3 5184.3 5187.2 5217.2 5110.9 5149.5 5156.1 5168.9 5189.3 4063.5 5448.5 5513.6 5538.6 5591.9 5866.5 5984.0 5995.5 6001.3 6013.5 6117.5 6121.8 6121.8 6133.4 6206.2 5759.5 5762.5 5771.5 5788.9 5789.5 6230.4 6249.4 6272.2 6283.2 6287.7 5989.9 6056.2 6116.8 6165.2 6172.2 5246.7 6188.3 6223.3 6275.5 6276.3 5918.4 5918.7 6102.1 6189.0 6236.0 6064.2 6143.9 6147.9 6160.7 6191.9 4556.2 4610.9 4901.9 4915.5 4933.6 4204.6 4346.3 4354.7 4412.8 4428.4 4799.9 5543.9 5561.7 5705.0 5716.4 5789.6 6157.5 6200.5 6205.4 6211.7 5667.0 5679.1 5688.3 5691.3 5692.6 4464.4 5253.8 5317.4 5374.7 5425.3 6287.1 6307.5 6318.9 6336.1 6347.6 6070.8 6154.3 6177.8 6272.3 6297.1 5382.0 6065.9 6260.9 6295.3 6347.9 5399.3 5758.7 6131.6 6140.0 6179.8 6064.4 6075.2 6106.2 6117.9 6147.2 5937.7 5946.7 6015.5 6086.5 6120.3 6076.3 6079.8 6084.1 6102.6 6110.1 5763.2 5773.6 5890.1 5954.2 5963.5 6015.3 6062.9 6114.0 6121.2 6123.1 5906.8 5921.8 5941.0 5944.8 5952.4 04:02:45 INFO - PROCESS | 1663 | 04:02:45 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:64644.53 Median:36302.59 stddev:145856.15 (401.8%) stddev-sans-first:146185.82 04:02:45 INFO - PROCESS | 1663 | Values: 507.5 534.2 552.7 581.7 598.1 31450.8 38385.0 38453.8 38560.6 38651.0 39556.0 40099.8 40209.8 40258.0 40481.0 9476.4 9696.7 9735.5 9751.5 9753.6 9554.6 9667.0 9678.6 9695.0 9703.3 8611.2 9649.5 9710.8 9748.7 9762.0 8185.8 8406.5 9689.9 9717.3 9768.4 9584.1 9678.0 9679.0 9714.0 9722.0 32195.0 38624.6 38858.2 38866.6 39093.0 2966.7 2985.2 3117.1 3244.0 3436.7 27833.2 28226.0 29359.6 30131.8 30919.0 2659.9 2730.1 2740.4 2743.3 2772.5 284732.6 314423.0 316632.0 341741.0 346346.0 35768.5 51630.5 59250.3 62667.0 62787.1 30125.5 32524.0 35482.5 35628.1 35793.9 15049.0 15198.5 15237.5 15270.8 15321.7 12871.3 12895.7 12898.7 12899.6 12916.5 7654.5 7733.7 8126.5 8290.3 8457.7 3106.7 3320.3 3417.8 3492.6 3495.3 988.6 996.7 1085.9 1116.5 1134.6 30074.0 30097.6 30338.2 30645.5 30714.5 914.2 1054.2 1063.3 1125.1 1159.3 15387.7 15419.5 15737.4 15966.4 16360.0 637205.0 651940.7 652367.0 653518.7 656967.0 59445.7 59558.1 60024.4 60110.7 60274.0 1459.9 1483.7 1502.2 1503.0 1503.6 28854.3 29155.3 29226.6 29737.9 29753.9 54924.5 55325.0 55708.7 55887.4 55963.2 578663.0 602840.0 603244.0 603314.0 603639.0 27410.0 27648.2 27857.4 27928.7 27956.4 45626.5 45766.6 46554.0 46799.0 46945.8 36324.9 36330.5 36465.8 37131.6 37243.0 31486.8 31897.5 32224.4 33833.0 36280.3 33901.3 37531.0 38033.0 38320.8 38433.6 30269.4 31403.5 31467.7 31501.7 31519.7 23883.6 24593.5 24723.9 25057.9 25276.4 04:02:45 INFO - PROCESS | 1663 | 04:02:45 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:34396.11 Median:12137.10 stddev:100832.17 (830.8%) stddev-sans-first:101082.70 04:02:45 INFO - PROCESS | 1663 | Values: 391.0 391.8 394.2 396.4 405.8 20025.7 20296.9 20790.7 20848.4 21285.9 19999.7 20160.6 21931.9 22077.2 22212.8 5026.2 5384.5 5390.8 5392.8 5396.4 5340.9 5413.1 5653.5 6069.9 6081.1 5762.2 6015.8 6054.7 6056.7 6074.2 5239.6 5991.5 6065.2 6125.3 6150.4 5701.9 5935.9 5984.9 5995.7 6001.6 12598.2 13441.7 13801.7 13969.0 14017.1 2015.7 2093.5 2197.0 2457.3 2462.8 8042.2 8170.3 9700.1 10123.8 10332.3 1641.9 1668.1 1671.3 1716.4 1740.1 117382.0 122475.0 122871.8 124949.4 124970.0 11752.6 11910.4 11911.6 11941.6 12006.7 15227.6 15280.3 15299.9 15321.1 15339.6 7254.6 7388.0 8523.8 8937.5 8980.6 8828.9 8865.0 8868.4 8914.6 8933.7 3846.0 4599.3 4681.7 4719.5 4753.4 1939.5 1993.6 2019.9 2021.8 2069.9 904.2 958.3 998.1 1011.6 1025.1 19049.5 19911.7 20236.8 20453.5 20485.9 947.7 949.9 991.3 999.6 1013.3 10633.1 10716.0 10735.7 10743.7 10781.7 592412.0 597573.0 605715.0 615279.0 616802.0 92100.0 115038.8 119666.4 122619.8 129159.0 968.9 996.3 1068.3 1070.0 1075.1 18303.5 18584.5 18633.1 18713.8 18739.3 48063.8 48435.5 50176.0 51045.0 51535.7 70908.5 72425.0 72548.0 72993.3 73389.3 6692.0 7966.5 8034.7 8104.6 8474.9 10596.5 11405.8 12208.4 12514.1 12671.2 10815.6 10869.6 10891.3 11180.2 11202.0 9417.8 9992.4 10696.0 10710.9 10880.9 10521.3 10797.1 10923.2 11083.7 11085.6 8009.3 8152.3 8170.1 8196.4 8340.6 10007.8 10895.9 11177.9 11230.7 11243.9 04:02:45 INFO - PROCESS | 1663 | 04:02:45 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5711.24 Median:4967.00 stddev:3155.01 (63.5%) stddev-sans-first:3146.71 04:02:45 INFO - PROCESS | 1663 | Values: 1335.2 1628.9 1795.1 1807.5 1984.4 7930.2 7975.7 8615.2 8631.6 8896.0 8721.0 8726.5 8800.9 8808.5 8848.4 2465.8 2487.9 2488.1 2492.0 2497.0 2445.9 2508.2 2517.7 2519.3 2519.6 2499.3 2503.5 2527.3 2528.6 2542.5 2464.4 2468.0 2481.7 2491.5 2493.8 2450.9 2462.9 2470.7 2481.6 2487.0 8899.7 8909.0 8919.9 8952.4 8969.5 5248.2 5534.1 5536.9 5547.4 5589.8 3542.3 3572.5 3578.1 3603.7 3604.9 1023.8 1039.5 1039.5 1055.0 1055.8 11565.7 11655.8 11688.2 11698.4 11721.8 4102.6 4212.5 4759.5 4853.3 4988.4 8654.4 9928.9 10075.4 10089.9 10110.2 5388.3 5464.3 5464.8 5479.0 5505.9 4444.4 4457.6 4815.7 4955.6 4988.7 4117.8 4130.1 4142.0 4147.0 4148.1 1299.5 1341.1 1356.1 1389.7 1403.5 915.6 935.7 943.3 950.7 970.8 6027.5 6080.2 6090.8 6144.4 6181.6 465.2 475.4 484.5 488.4 488.7 3695.9 4021.8 4093.7 4169.4 4178.9 10444.5 10870.7 10893.0 10906.4 10922.7 10495.5 10604.7 10632.7 10811.1 10855.5 6237.5 8079.1 8242.3 8314.2 8377.7 5991.8 6032.8 6127.3 6194.7 6200.3 8268.9 9636.3 9673.9 9914.9 9934.3 9710.3 9713.0 9980.0 10034.2 10140.6 6633.9 6875.6 7017.9 7234.7 7287.1 8366.3 8409.2 8462.4 8472.8 8477.1 7320.6 7352.5 7487.4 7556.0 7623.0 6850.0 7057.4 7095.4 7098.1 7109.7 7028.0 7111.0 7130.1 7146.7 7185.3 4693.2 4833.4 4978.4 5008.4 5251.9 4767.0 4990.6 5060.5 5119.3 5321.6 04:02:45 INFO - PROCESS | 1663 | 04:02:45 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5212.16 Median:5889.35 stddev:1691.51 (28.7%) stddev-sans-first:1655.90 04:02:45 INFO - PROCESS | 1663 | Values: 318.8 322.8 328.9 329.4 333.2 6087.1 6210.3 6290.2 6293.3 6301.1 6061.1 6087.8 6151.4 6154.6 6210.8 3667.6 4354.3 4605.3 4633.6 4638.9 4501.9 4598.6 4606.1 4627.2 4645.9 4573.5 4582.2 4588.7 4610.8 4632.0 4208.3 4516.3 4525.0 4529.0 4532.0 3217.8 3466.8 3824.9 3853.4 3863.5 5159.3 5623.6 5903.4 5909.7 5951.3 5011.9 5173.5 5179.3 5193.1 5248.2 5332.4 6376.9 6432.3 6450.2 6457.9 3224.3 3873.9 4139.3 4254.6 4275.8 5632.7 6014.7 6678.4 6903.7 6904.4 4313.3 4314.0 4334.6 4347.1 4358.7 3745.2 3799.6 3816.3 4067.7 4451.4 4882.0 5116.8 5179.2 5214.5 5257.1 5562.0 5667.1 5734.6 5873.2 6448.0 1399.8 1419.8 1523.0 1524.2 1529.9 920.8 959.7 984.0 985.1 987.9 5185.6 5307.6 5575.9 6006.0 6047.9 5530.7 6730.3 6777.2 6781.0 6820.4 5688.9 6092.7 6111.7 6133.3 6139.4 2951.7 3052.0 3271.7 3576.4 3632.3 6735.3 6844.6 7092.3 7167.6 7196.6 7012.0 7065.8 7089.3 7097.3 7098.4 5636.0 6689.6 6836.9 6917.5 7144.9 5431.6 6469.5 6895.3 6916.6 6933.8 6292.4 6367.1 6621.7 6750.0 6801.9 5677.8 6669.0 7153.3 7182.0 7188.9 3830.0 3929.1 4358.9 4370.9 4399.2 6015.6 6758.7 6813.5 6814.7 6824.2 6578.5 6631.1 6639.7 6662.8 6683.4 5507.4 6315.8 6545.5 6594.4 6615.6 4955.5 6225.6 6398.5 6422.9 6512.2 5256.6 5494.5 6042.9 6595.1 6635.5 5875.3 6030.6 6046.4 6066.8 6448.3 04:02:45 INFO - PROCESS | 1663 | 04:02:45 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:17582.41 Median:574.66 stddev:24439.46 (4252.8%) stddev-sans-first:24475.02 04:02:45 INFO - PROCESS | 1663 | Values: 668.9 730.3 732.5 762.1 786.0 14872.3 14967.8 15013.8 15154.8 15163.2 13490.4 14058.0 14095.8 14096.2 14108.0 741.2 910.0 922.2 929.8 942.4 888.6 902.4 934.2 940.7 940.8 968.1 987.6 990.0 991.6 994.1 976.1 978.8 985.0 987.2 989.5 711.6 738.4 742.0 742.0 748.1 13471.7 14276.9 14947.0 15196.7 15267.5 9286.9 12901.2 12992.4 13240.0 13294.2 10108.2 10115.4 10352.3 10467.2 10632.1 3502.5 3543.9 3557.7 3626.1 3642.8 90085.0 91047.1 91168.0 92359.1 92662.5 9549.3 9577.1 9752.8 9810.3 9930.3 22508.9 22659.7 22884.0 22906.4 22956.5 7526.0 7580.9 7706.6 7723.7 7751.3 4101.9 4106.3 4121.9 4126.4 4150.4 3548.4 3594.9 3604.5 3617.3 3639.5 623.3 635.7 660.0 681.1 694.2 506.9 535.4 572.7 576.6 584.9 7052.4 7935.2 8073.4 8136.0 8173.3 469.9 487.8 507.2 513.2 513.9 3784.2 3843.6 3850.0 3867.9 3868.1 76857.0 77853.2 79681.6 80074.0 94363.0 52866.5 73983.6 74743.6 74823.6 74870.3 40841.4 52406.2 59927.4 65617.0 67114.0 6978.2 7265.2 8023.4 8057.5 8165.5 43856.9 43983.0 44228.0 44771.0 45309.0 63429.7 67458.0 67589.3 67671.3 67784.0 10765.2 10983.6 11068.9 11279.3 11299.8 10410.9 11781.0 12034.6 12442.8 12454.2 11313.9 11365.5 11610.1 11743.8 11873.9 11298.5 11353.5 11418.7 11898.8 11933.0 11329.8 11480.8 11613.1 11702.2 11775.2 9461.7 9477.7 9761.5 9971.1 10138.8 9403.2 9504.8 9504.9 9539.2 9637.2 04:02:45 INFO - PROCESS | 1663 | -------- Summary: end -------- 04:02:45 INFO - PROCESS | 1663 | 04:02:45 INFO - TEST-INFO | 1663: exit 0 04:02:45 INFO - TEST-OK | dromaeo_css | took 1112180ms 04:02:45 INFO - TEST-START | kraken 04:02:45 INFO - operating with platform_type : mac_ 04:02:45 INFO - Initialising browser for kraken test... 04:02:45 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpiVpPxX/profile http://localhost:49270/getInfo.html) 04:02:48 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 04:02:48 INFO - PROCESS | 1676 | colorDepth:24 04:02:48 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 04:02:48 INFO - PROCESS | 1676 | __metrics 04:02:48 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:02:49 INFO - TEST-INFO | 1676: exit 0 04:02:49 INFO - Browser initialized. 04:02:49 INFO - Running cycle 1/1 for kraken test... 04:02:49 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpiVpPxX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:01 INFO - PROCESS | 1679 | RSS: Main: 249491456 04:03:01 INFO - PROCESS | 1679 | 04:03:03 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 04:03:04 INFO - PROCESS | 1679 | RSS: Main: 261656576 04:03:04 INFO - PROCESS | 1679 | 04:03:07 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 04:03:08 INFO - PROCESS | 1679 | RSS: Main: 270770176 04:03:08 INFO - PROCESS | 1679 | 04:03:11 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 04:03:12 INFO - PROCESS | 1679 | RSS: Main: 274714624 04:03:12 INFO - PROCESS | 1679 | 04:03:14 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 04:03:14 INFO - PROCESS | 1679 | RSS: Main: 274546688 04:03:14 INFO - PROCESS | 1679 | 04:03:17 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:03:17 INFO - PROCESS | 1679 | RSS: Main: 276385792 04:03:17 INFO - PROCESS | 1679 | 04:03:20 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 04:03:21 INFO - PROCESS | 1679 | RSS: Main: 276881408 04:03:21 INFO - PROCESS | 1679 | 04:03:24 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 04:03:24 INFO - PROCESS | 1679 | RSS: Main: 276905984 04:03:24 INFO - PROCESS | 1679 | 04:03:27 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 04:03:28 INFO - PROCESS | 1679 | RSS: Main: 277090304 04:03:28 INFO - PROCESS | 1679 | 04:03:29 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:03:30 INFO - PROCESS | 1679 | RSS: Main: 276557824 04:03:30 INFO - PROCESS | 1679 | 04:03:32 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:03:33 INFO - PROCESS | 1679 | RSS: Main: 276553728 04:03:33 INFO - PROCESS | 1679 | 04:03:35 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:03:36 INFO - PROCESS | 1679 | RSS: Main: 277417984 04:03:36 INFO - PROCESS | 1679 | 04:03:39 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:03:39 INFO - PROCESS | 1679 | RSS: Main: 276865024 04:03:39 INFO - PROCESS | 1679 | 04:03:42 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:03:43 INFO - PROCESS | 1679 | RSS: Main: 276934656 04:03:43 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 04:03:45 INFO - PROCESS | 1679 | RSS: Main: 278642688 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | __start_tp_report 04:03:45 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 04:03:45 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 04:03:45 INFO - PROCESS | 1679 | |i|pagename|runs| 04:03:45 INFO - PROCESS | 1679 | |0;ai-astar;116;112;116;116;115;128;117;116;119;96 04:03:45 INFO - PROCESS | 1679 | |1;audio-beat-detection;154;122;166;216;125;160;154;204;166;123 04:03:45 INFO - PROCESS | 1679 | |2;audio-dft;195;198;216;220;198;199;201;196;205;198 04:03:45 INFO - PROCESS | 1679 | |3;audio-fft;67;72;80;139;56;56;56;65;129;57 04:03:45 INFO - PROCESS | 1679 | |4;audio-oscillator;80;85;140;110;119;80;120;79;83;116 04:03:45 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;102;131;88;85;88;86;134;119;100;83 04:03:45 INFO - PROCESS | 1679 | |6;imaging-darkroom;94;96;94;94;111;152;131;94;95;95 04:03:45 INFO - PROCESS | 1679 | |7;imaging-desaturate;91;96;90;92;94;89;91;93;93;95 04:03:45 INFO - PROCESS | 1679 | |8;json-parse-financial;61;64;62;62;62;61;61;81;64;61 04:03:45 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;63;64;87;59;68;96;106;98;88;90 04:03:45 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;107;111;87;87;109;110;112;82;88;84 04:03:45 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;174;133;126;155;146;151;153;167;259;185 04:03:45 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;171;166;172;190;232;226;177;172;180;172 04:03:45 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;70;68;72;70;70;68;72;69;69;68 04:03:45 INFO - PROCESS | 1679 | __end_tp_report 04:03:45 INFO - PROCESS | 1679 | __start_cc_report 04:03:45 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1090 04:03:45 INFO - PROCESS | 1679 | __end_cc_report 04:03:45 INFO - PROCESS | 1679 | __startTimestamp1461409425450__endTimestamp 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | ------- Summary: start ------- 04:03:45 INFO - PROCESS | 1679 | Number of tests: 14 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:115.10 Median:116.50 stddev:7.91 (6.8%) stddev-sans-first:8.38 04:03:45 INFO - PROCESS | 1679 | Values: 116.0 112.0 116.0 116.0 115.0 128.0 117.0 116.0 119.0 96.0 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:159.00 Median:163.00 stddev:32.05 (19.7%) stddev-sans-first:33.94 04:03:45 INFO - PROCESS | 1679 | Values: 154.0 122.0 166.0 216.0 125.0 160.0 154.0 204.0 166.0 123.0 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:202.60 Median:200.00 stddev:8.62 (4.3%) stddev-sans-first:8.69 04:03:45 INFO - PROCESS | 1679 | Values: 195.0 198.0 216.0 220.0 198.0 199.0 201.0 196.0 205.0 198.0 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:77.70 Median:61.00 stddev:30.81 (50.5%) stddev-sans-first:32.44 04:03:45 INFO - PROCESS | 1679 | Values: 67.0 72.0 80.0 139.0 56.0 56.0 56.0 65.0 129.0 57.0 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:79.50 stddev:22.26 (28.0%) stddev-sans-first:22.24 04:03:45 INFO - PROCESS | 1679 | Values: 80.0 85.0 140.0 110.0 119.0 80.0 120.0 79.0 83.0 116.0 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:101.60 Median:84.00 stddev:19.59 (23.3%) stddev-sans-first:20.78 04:03:45 INFO - PROCESS | 1679 | Values: 102.0 131.0 88.0 85.0 88.0 86.0 134.0 119.0 100.0 83.0 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:105.60 Median:94.00 stddev:20.23 (21.5%) stddev-sans-first:21.01 04:03:45 INFO - PROCESS | 1679 | Values: 94.0 96.0 94.0 94.0 111.0 152.0 131.0 94.0 95.0 95.0 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:93.00 stddev:2.22 (2.4%) stddev-sans-first:2.30 04:03:45 INFO - PROCESS | 1679 | Values: 91.0 96.0 90.0 92.0 94.0 89.0 91.0 93.0 93.0 95.0 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:62.00 stddev:6.12 (9.9%) stddev-sans-first:6.40 04:03:45 INFO - PROCESS | 1679 | Values: 61.0 64.0 62.0 62.0 62.0 61.0 61.0 81.0 64.0 61.0 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:81.90 Median:87.50 stddev:16.88 (19.3%) stddev-sans-first:16.45 04:03:45 INFO - PROCESS | 1679 | Values: 63.0 64.0 87.0 59.0 68.0 96.0 106.0 98.0 88.0 90.0 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:97.70 Median:83.00 stddev:12.93 (15.6%) stddev-sans-first:13.27 04:03:45 INFO - PROCESS | 1679 | Values: 107.0 111.0 87.0 87.0 109.0 110.0 112.0 82.0 88.0 84.0 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:164.90 Median:161.00 stddev:37.52 (23.3%) stddev-sans-first:39.65 04:03:45 INFO - PROCESS | 1679 | Values: 174.0 133.0 126.0 155.0 146.0 151.0 153.0 167.0 259.0 185.0 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.80 Median:178.50 stddev:23.71 (13.3%) stddev-sans-first:24.54 04:03:45 INFO - PROCESS | 1679 | Values: 171.0 166.0 172.0 190.0 232.0 226.0 177.0 172.0 180.0 172.0 04:03:45 INFO - PROCESS | 1679 | 04:03:45 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.51 (2.2%) stddev-sans-first:1.59 04:03:45 INFO - PROCESS | 1679 | Values: 70.0 68.0 72.0 70.0 70.0 68.0 72.0 69.0 69.0 68.0 04:03:45 INFO - PROCESS | 1679 | -------- Summary: end -------- 04:03:45 INFO - PROCESS | 1679 | 04:03:46 INFO - TEST-INFO | 1679: exit 0 04:03:46 INFO - TEST-OK | kraken | took 60413ms 04:03:46 INFO - SUITE-END | took 1172s 04:03:46 INFO - Completed test suite (00:19:32) 04:03:46 INFO - javascript benchmark 04:03:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3412.112850658829, 3433.313337332534, 3491.5984661763905, 3517.0328159756073, 3525.2773181497796, 5542.39033706293, 5673.574481913853, 5676.290463692038, 5678.205051292817, 5738.512226460745, 5636.549076073915, 5665.575081868866, 5722.313322401307, 5799.768009279624, 5823.621464604808, 5139.537441630253, 5168.173092305232, 5187.247849061884, 5236.764345604438, 5296.364436267634, 5254.4220135785035, 5273.1826566882, 5313.070212712779, 5330.466953304677, 5331.493508116722, 4191.790410479494, 5029.0, 5102.821401250975, 5227.32044834171, 5234.371875374979, 5155.896882062338, 5166.302549155854, 5184.300119483859, 5187.170052791573, 5217.217417387385, 5110.897782044338, 5149.459306772772, 5156.123459011977, 5168.9224661630105, 5189.273501709764, 4063.5326937402283, 5448.482394172547, 5513.61404701671, 5538.556915446755, 5591.916121258144, 5866.472017518444, 5984.042553191512, 5995.460408563206, 6001.3098493672915, 6013.458788709037, 6117.510599152057, 6121.816345509642, 6121.818815678045, 6133.3559976202305, 6206.193194884636, 5759.539236861041, 5762.538996880239, 5771.538276937877, 5788.855278618068, 5789.536837053068, 6230.43926046658, 6249.437550620466, 6272.247330320391, 6283.183186185766, 6287.654179020198, 5989.940100598938, 6056.242969628796, 6116.761878222105, 6165.198524191826, 6172.22847144107, 5246.685198888079, 6188.257409110935, 6223.315435302113, 6275.497960163268, 6276.301190488042, 5918.437748413894, 5918.704064796829, 6102.145699602059, 6189.04069869171, 6235.96882015587, 6064.241969753781, 6143.880361275353, 6147.862645410524, 6160.722767475474, 6191.938080619227, 4556.157110934488, 4610.861674149781, 4901.877453063702, 4915.5330243626795, 4933.58064564516, 4204.62158405745, 4346.2828633275785, 4354.716943398669, 4412.84555040572, 4428.402165707653, 4799.904001919942, 5543.861403464945, 5561.6663000219305, 5705.0, 5716.399778023331, 5789.623674461147, 6157.507399408037, 6200.534959877937, 6205.410486003822, 6211.65835879022, 5666.97166514173, 5679.091345384719, 5688.260526131577, 5691.288588926384, 5692.57305702074, 4464.441944756905, 5253.816116435983, 5317.361916569959, 5374.6506477078865, 5425.294711687456, 6287.1198032275515, 6307.495400367868, 6318.873622527523, 6336.144620476177, 6347.619142851444, 6070.7875224366935, 6154.323024467216, 6177.84555386101, 6272.278687950944, 6297.055441683784, 5382.0, 6065.9081365352895, 6260.937390626035, 6295.307516173309, 6347.873042539031, 5399.325084364455, 5758.733078722675, 6131.60144590618, 6140.048292514667, 6179.84550386244, 6064.363241859718, 6075.210222671201, 6106.236720409949, 6117.938820611915, 6147.170132032118, 5937.732802023833, 5946.732397042057, 6015.458608725061, 6086.513078953584, 6120.325235636462, 6076.270847498328, 6079.756809727562, 6084.117802918464, 6102.572819902564, 6110.083487476914, 5763.221965034667, 5773.624714393551, 5890.087036509177, 5954.166416701579, 5963.493103086286, 6015.2781666200335, 6062.939370606414, 6113.98035644981, 6121.173641558511, 6123.142760013513, 5906.822795316148, 5921.763129474945, 5941.019731744386, 5944.791932282349, 5952.434518720715], "value": 5615.113570625655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.47476361965374, 534.2307077807956, 552.6794459213654, 581.6597290585007, 598.1446531460014, 31450.842745786296, 38385.0, 38453.80773096134, 38560.614393856056, 38651.0, 39556.01109972252, 40099.79700608979, 40209.79895100528, 40258.0, 40481.0, 9476.44136083257, 9696.709098727015, 9735.51322433879, 9751.463669498175, 9753.561089750978, 9554.570044347985, 9667.033296670346, 9678.564464599074, 9695.03049695032, 9703.320767546275, 8611.181937715906, 9649.517524123801, 9710.805783884318, 9748.658796942109, 9761.951190244039, 8185.8362832743305, 8406.537640429804, 9689.90310096897, 9717.31978761487, 9768.413895166243, 9584.137427631547, 9678.0, 9679.0, 9714.0, 9721.951390243074, 32195.034148975566, 38624.61375386238, 38858.22283554341, 38866.61133388658, 39093.0, 2966.7033296670375, 2985.208919636298, 3117.1427857339413, 3243.96756032439, 3436.7250619950346, 27833.16500504988, 28226.0, 29359.55960660592, 30131.849340753375, 30919.0, 2659.853708046076, 2730.0990673077836, 2740.397112635237, 2743.3141714571357, 2772.514809908258, 284732.576337117, 314422.99999999773, 316632.0, 341741.0, 346346.0, 35768.46347304792, 51630.48369516332, 59250.25997920156, 62667.0, 62787.05819412712, 30125.548116778267, 32524.0, 35482.46776298358, 35628.10929726777, 35793.92618221458, 15049.0, 15198.544043678707, 15237.466688666065, 15270.770938435933, 15321.693566128615, 12871.292078935561, 12895.742085158245, 12898.742025159632, 12899.613011609667, 12916.547920822726, 7654.464187506821, 7733.690652373842, 8126.471779334324, 8290.336773058141, 8457.703980360659, 3106.701041229474, 3320.269540701042, 3417.79493230407, 3492.633273506245, 3495.3184129094584, 988.5699720621552, 996.7408473796866, 1085.8642669666292, 1116.4808364110727, 1134.6085600467825, 30074.0, 30097.60656507833, 30338.241543961576, 30645.540316895265, 30714.53928191079, 914.1909410172045, 1054.2409465185056, 1063.276971659279, 1125.0549538387793, 1159.287038471334, 15387.692246155015, 15419.460318888785, 15737.370505179893, 15966.36134554628, 16360.018398896103, 637205.0, 651940.7402962955, 652367.0, 653518.732406335, 656967.0, 59445.70277148673, 59558.10662840061, 60024.39975600188, 60110.699446503364, 60274.0, 1459.868611824941, 1483.7403454395437, 1502.188818038247, 1503.0230350272411, 1503.6015455904194, 28854.278643034093, 29155.271118222216, 29226.56160157557, 29737.851310743306, 29753.85123074371, 54924.45075549193, 55325.0, 55708.72145639246, 55887.44112558822, 55963.160552592555, 578663.0, 602840.0, 603244.0, 603314.0, 603639.0, 27410.0, 27648.170554883385, 27857.44285114246, 27928.720712792612, 27956.44087118287, 45626.54373456356, 45766.62700119002, 46554.0, 46799.0, 46945.765271173426, 36324.91025269246, 36330.455043173846, 36465.81767091148, 37131.628683712814, 37243.0, 31486.842565787025, 31897.521537176497, 32224.35551289008, 33833.0, 36280.27439451249, 33901.32197356089, 37531.0, 38033.0, 38320.80839595784, 38433.615663844124, 30269.394612108073, 31403.528947065355, 31467.68532314739, 31501.684983149877, 31519.68480315259, 23883.64174537418, 24593.50812983766, 24723.87638061798, 25057.87471062633, 25276.368090797878], "value": 18276.984675129923, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.0048925484642, 391.81388840300843, 394.2312490643246, 396.423204237834, 405.76262886211566, 20025.699614505775, 20296.8985155074, 20790.688139677917, 20848.374548763542, 21285.893570532164, 19999.700004499908, 20160.59678806423, 21931.903404829736, 22077.227297044607, 22212.77787222127, 5026.220935754964, 5384.542313903323, 5390.811321603745, 5392.811251606195, 5396.406395296514, 5340.91988620171, 5413.133898576229, 5653.547716182696, 6069.878602427949, 6081.087836824468, 5762.164486149506, 6015.789447369321, 6054.727537260812, 6056.666883321415, 6074.210352654149, 5239.633225674204, 5991.460768530831, 6065.150878876961, 6125.295591007047, 6150.384961503859, 5701.942980570224, 5935.851603709899, 5984.8503787405225, 5995.6702381369005, 6001.639901605874, 12598.181118227287, 13441.731165376637, 13801.654958626013, 13969.0, 14017.088889222168, 2015.6573382525005, 2093.5184907471216, 2196.967045494319, 2457.348802567321, 2462.778349948513, 8042.235987581171, 8170.264676179172, 9700.078492543196, 10123.79752404955, 10332.276740628158, 1641.917904104802, 1668.099226417745, 1671.264643556831, 1716.4078392954411, 1740.0718077578272, 117382.0, 122475.0, 122871.77128228692, 124949.37525312406, 124970.0, 11752.647420577225, 11910.404479775976, 11911.583094591648, 11941.58204462857, 12006.699832504257, 15227.619309517351, 15280.31238594266, 15299.929004969545, 15321.080735155927, 15339.61650958735, 7254.637268136572, 7387.963060184665, 8523.82952340962, 8937.46375217476, 8980.550972451481, 8828.8675669865, 8865.024847266795, 8868.423552469068, 8914.55427228636, 8933.704612831103, 3845.9615403846165, 4599.310103484504, 4681.7190968542, 4719.457262414798, 4753.405824271966, 1939.544719492474, 1993.6311782320026, 2019.9394018179478, 2021.8382529397613, 2069.906854191565, 904.1500989070253, 958.3100167879115, 998.1366118307757, 1011.5953618552638, 1025.0876719719456, 19049.523761906064, 19911.701324480146, 20236.797632023492, 20453.48866278355, 20485.897570512054, 947.6588428165993, 949.9192568631605, 991.3407583956732, 999.5651891427252, 1013.3109485549896, 10633.096186824207, 10715.981981711724, 10735.677929662123, 10743.731406714895, 10781.730456738487, 592412.0, 597573.0, 605715.0, 615279.0, 616802.0, 92100.0, 115038.84961150448, 119666.40166799285, 122619.77380226261, 129159.0, 968.8595153702673, 996.2976101848179, 1068.278911734576, 1069.983950240747, 1075.102289588187, 18303.54241143982, 18584.535386615444, 18633.068346582346, 18713.812861871207, 18739.250429982647, 48063.75968120137, 48435.51564484451, 50175.99999999854, 51045.0, 51535.742321288155, 70908.45492704336, 72425.0, 72548.0, 72993.27006730078, 73389.26610733825, 6691.966540167268, 7966.522008679498, 8034.718784842503, 8104.554249516097, 8474.872876906975, 10596.470176491299, 11405.775873704548, 12208.389580521116, 12514.12401131912, 12671.17637353569, 10815.56737730482, 10869.565217391215, 10891.346519208873, 11180.217384782987, 11202.047825934887, 9417.775689160366, 9992.350497217658, 10696.0, 10710.946445267724, 10880.945595271973, 10521.329377446398, 10797.136229101496, 10923.18779354396, 11083.667489975314, 11085.612003579836, 8009.3192078673965, 8152.266296033148, 8170.10128885834, 8196.426250162669, 8340.582970851554, 10007.799844003224, 10895.945520272666, 11177.88822111801, 11230.719232019264, 11243.887561124611], "value": 9326.734088078803, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.205552696146, 1628.8615467685242, 1795.1293622593041, 1807.5119717676228, 1984.394759598322, 7930.246626570473, 7975.680972761083, 8615.224629783319, 8631.611577479012, 8896.02143764187, 8721.040685524587, 8726.52004139772, 8800.867986980184, 8808.515531645757, 8848.42485238459, 2465.778079972802, 2487.9253622391357, 2488.129154795825, 2492.028109037468, 2497.0386401235564, 2445.8532488050687, 2508.159766478232, 2517.7104632967166, 2519.2945975126904, 2519.6346529753173, 2499.262717498333, 2503.4993001399703, 2527.279725278296, 2528.5954247320433, 2542.4533725249066, 2464.371585245769, 2467.9506409871883, 2481.7146028206807, 2491.476789874129, 2493.8004959603277, 2450.901963921441, 2462.9014839406404, 2470.715867675204, 2481.6401621764744, 2487.0300582772734, 8899.688510902151, 8908.955455222747, 8919.866202006975, 8952.418092824011, 8969.461832290019, 5248.21276808478, 5534.142207957732, 5536.861578460531, 5547.44525547446, 5589.776408943638, 3542.2738338640515, 3572.4819901114192, 3578.141246100943, 3603.657652523006, 3604.945925811115, 1023.7696518283401, 1039.4646756920192, 1039.501039501036, 1055.0399136785566, 1055.757175849559, 11565.653030409017, 11655.825162622568, 11688.240264382788, 11698.415079246004, 11721.824172637333, 4102.5692302307825, 4212.515560710496, 4759.4764575896625, 4853.3447984522345, 4988.351514303117, 8654.437461564978, 9928.900710992943, 10075.445850478294, 10089.899101009043, 10110.24173187014, 5388.326459192601, 5464.3442786865035, 5464.7814087436855, 5478.972605136949, 5505.944940550623, 4444.355568442557, 4457.621102206284, 4815.686980346266, 4955.603551715854, 4988.725620090857, 4117.814698338582, 4130.132672138884, 4142.032534546067, 4146.979265103715, 4148.108156746314, 1299.512682743971, 1341.148370784559, 1356.0643156222175, 1389.7290028444559, 1403.4947418929178, 915.5834095486538, 935.7005758157325, 943.3208090175063, 950.6720181537358, 970.8203982263304, 6027.547933904974, 6080.179175811209, 6090.786822461193, 6144.446999770043, 6181.629102253879, 465.24165610055394, 475.3772557949098, 484.5348465473115, 488.38707422184933, 488.655497873998, 3695.8706445274825, 4021.7989100544855, 4093.733907296076, 4169.353750168729, 4178.937315940263, 10444.529996150191, 10870.72823179411, 10893.0, 10906.400147991937, 10922.672319830417, 10495.527701253463, 10604.681859544226, 10632.734181645366, 10811.081058110149, 10855.511501982272, 6237.500999919996, 8079.111297757242, 8242.340612750966, 8314.168583141638, 8377.664893404317, 5991.7902873399225, 6032.758689652364, 6127.264728232462, 6194.659293738708, 6200.255969283715, 8268.875966860382, 9636.277279203947, 9673.854892176481, 9914.900850991398, 9934.304598678023, 9710.271729620166, 9713.0, 9980.001999799963, 10034.19726421899, 10140.645077422254, 6633.867322653424, 6875.5530890491955, 7017.859642807218, 7234.74678386254, 7287.125544934642, 8366.288865446506, 8409.159084091787, 8462.365322600706, 8472.830543388975, 8477.109903460294, 7320.597367144858, 7352.48532602734, 7487.363574096263, 7556.0, 7622.970898928796, 6850.0, 7057.400120989568, 7095.361417472453, 7098.112735908012, 7109.680064397218, 7028.016077749221, 7111.0, 7130.073090498202, 7146.749863754952, 7185.317394847481, 4693.155232058262, 4833.3958255218095, 4978.4025916890205, 5008.398992120969, 5251.949610078076, 4766.998930224691, 4990.5508504234795, 5060.519250671327, 5119.334486516729, 5321.600879934098], "value": 4563.770193120359, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.77367069380745, 322.79986408426777, 328.8602344003798, 329.3741890408225, 333.18203809647287, 6087.11736798164, 6210.254769427664, 6290.21372328459, 6293.27627322858, 6301.117843501907, 6061.090836374535, 6087.78692745754, 6151.4463698267145, 6154.5999510031925, 6210.844728881781, 3667.559892812853, 4354.3250796126495, 4605.332226827108, 4633.62930965522, 4638.8608341749805, 4501.864944051684, 4598.563136502027, 4606.101810147023, 4627.190241707688, 4645.88385290367, 4573.451185857685, 4582.221022426195, 4588.655850811202, 4610.838620648261, 4631.9536804632025, 4208.326667733163, 4516.345129956171, 4525.004499010212, 4529.0, 4532.0, 3217.758668099902, 3466.757326987112, 3824.9235015299814, 3853.402722578005, 3863.5363756349416, 5159.277701121846, 5623.622212557909, 5903.409659034105, 5909.734061967179, 5951.345352011275, 5011.874703132415, 5173.456787037345, 5179.326687530634, 5193.065248255312, 5248.160294352885, 5332.3867755207875, 6376.872462550769, 6432.260290066609, 6450.225972883284, 6457.93542064578, 3224.339010502841, 3873.922521549553, 4139.257664553683, 4254.617084462413, 4275.807588658487, 5632.74652640628, 6014.669193194372, 6678.395425783948, 6903.654817259167, 6904.447644188504, 4313.266744653416, 4313.956860431418, 4334.566543345641, 4347.130573885235, 4358.65130789536, 3745.1573395985683, 3799.601041890617, 3816.2558301131567, 4067.6745860331102, 4451.399061126771, 4881.9511804881495, 5116.795328186831, 5179.249008893765, 5214.530692237641, 5257.053730328577, 5561.971035358471, 5667.09326507765, 5734.627249228787, 5873.177755114288, 6447.967760161263, 1399.7900314952838, 1419.8438171801095, 1522.956774609396, 1524.215029259932, 1529.908205507673, 920.769807548113, 959.7168835193635, 983.9950800245953, 985.0986347492108, 987.9160271377013, 5185.611079169077, 5307.6019298552765, 5575.944240557624, 6005.969970150121, 6047.879042419127, 5530.695811730313, 6730.32696730323, 6777.186737591521, 6781.0, 6820.35206655367, 5688.866674996876, 6092.664903430265, 6111.724972376253, 6133.29467111279, 6139.447449729457, 2951.719586639266, 3052.016189476858, 3271.672832716757, 3576.3741345264475, 3632.2735452909524, 6735.29279425663, 6844.555103918229, 7092.255313192144, 7167.569945803269, 7196.617589732818, 7012.0, 7065.788026359218, 7089.291070892869, 7097.338498063226, 7098.39663628587, 5636.0, 6689.632070236086, 6836.863262734718, 6917.481188910952, 7144.857102858018, 5431.619786614899, 6469.547131700736, 6895.276365835367, 6916.619585922823, 6933.757318493828, 6292.402221788922, 6367.076773867856, 6621.702023408862, 6749.9662501689145, 6801.9319806801295, 5677.829665110054, 6668.966310221924, 7153.320434558708, 7181.964090179516, 7188.8921666174, 3829.961700383072, 3929.135590170158, 4358.869233922987, 4370.868873933787, 4399.230134726474, 6015.578909476295, 6758.749631318222, 6813.4889883257965, 6814.727410903508, 6824.18109826824, 6578.5395022347975, 6631.1379520662, 6639.6680165992475, 6662.83342916431, 6683.398494135551, 5507.449255074621, 6315.778947736807, 6545.509086818603, 6594.406503414716, 6615.636140012345, 4955.45489996093, 6225.62646241227, 6398.48812095022, 6422.9036564450635, 6512.218533775977, 5256.553192978639, 5494.5054945055135, 6042.939570604238, 6595.142631458071, 6635.535512514078, 5875.294964604104, 6030.638161710312, 6046.395360463918, 6066.786642671572, 6448.290688024407], "value": 4662.997618080678, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.8561959178776, 730.2952650692088, 732.5311800447711, 762.0740799928086, 786.0, 14872.33074511647, 14967.775483367745, 15013.849861501381, 15154.772678409832, 15163.241837908115, 13490.392932318045, 14058.0, 14095.78856317156, 14096.224707641075, 14108.0, 741.2143128284009, 909.958097977815, 922.2483675804198, 929.8419268724333, 942.3686130292721, 888.6489836514573, 902.4134312696734, 934.1592566689999, 940.666063547441, 940.8165407745493, 968.109339407743, 987.5802783816849, 990.044606954289, 991.6479649724353, 994.0705440413201, 976.1312431935547, 978.7846673731767, 985.0395864032582, 987.1806400687412, 989.4805227255677, 711.5730561663013, 738.4166508458311, 741.9591922444317, 741.9703211871519, 748.1022772672815, 13471.66320841977, 14276.928615356961, 14946.953713240078, 15196.696066078617, 15267.465638702703, 9286.860697089549, 12901.225926444444, 12992.41534130957, 13240.006999475077, 13294.202347859062, 10108.241881858816, 10115.443650599214, 10352.327098738559, 10467.162626989822, 10632.149428045737, 3502.4571191465366, 3543.875964341236, 3557.6975957043683, 3626.1478552540398, 3642.8360723767496, 90085.0, 91047.08952910452, 91168.0, 92359.07640923571, 92662.53668731681, 9549.331546791658, 9577.138057574852, 9752.804943901083, 9810.31327807061, 9930.30487865857, 22508.887455562945, 22659.660105098435, 22884.0, 22906.427339316317, 22956.540869182856, 7526.0, 7580.924190758022, 7706.5761383123345, 7723.65243564041, 7751.302382785577, 4101.89745256365, 4106.281400754856, 4121.855735049259, 4126.381042843597, 4150.398192262105, 3548.449990251515, 3594.9101272467874, 3604.5494313210847, 3617.312710585033, 3639.526861507987, 623.329920335641, 635.7361694896658, 659.960402375859, 681.1315572644918, 694.1808665774333, 506.94049436676784, 535.4351159526659, 572.6936089192262, 576.6338375131821, 584.9005669036274, 7052.4484613384975, 7935.166807485246, 8073.394495412867, 8136.0, 8173.3244684839465, 469.9271612900006, 487.8487668822676, 507.17417297727883, 513.2224679610393, 513.8515418040677, 3784.1863999239745, 3843.5964223756664, 3849.9615003850163, 3867.9226415472094, 3868.1296708240984, 76857.0, 77853.2479670527, 79681.60159199283, 80074.0, 94363.0, 52866.47133528616, 73983.63008184925, 74743.62628186824, 74823.62588187025, 74870.25129748741, 40841.36634534645, 52406.21390679143, 59927.40072599305, 65617.0, 67114.0, 6978.232394436709, 7265.200827909031, 8023.438359315025, 8057.476264042818, 8165.469244499089, 43856.90357741082, 43983.0, 44228.0, 44771.0, 45309.0, 63429.68285158544, 67458.0, 67589.32410676026, 67671.3232867665, 67783.98324025045, 10765.192610554082, 10983.61557345489, 11068.944655276671, 11279.32324060559, 11299.830502542303, 10410.947945260225, 11781.0, 12034.578789742667, 12442.75114497723, 12454.190477618926, 11313.886861131612, 11365.54537818478, 11610.129240306842, 11743.823842642538, 11873.881261187278, 11298.49156787963, 11353.54585816558, 11418.657440276806, 11898.821517677416, 11933.0, 11329.773404532029, 11480.827787583026, 11613.070954323803, 11702.239354441934, 11775.175737698279, 9461.716148515556, 9477.715668529956, 9761.511924403609, 9971.102600765966, 10138.79722405533, 9403.153716165578, 9504.809903801746, 9504.85742713846, 9539.23686105096, 9637.22902167839], "value": 6830.673700694124, "unit": "score"}], "name": "dromaeo_css", "value": 7198.584779368531, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 116.0, 116.0, 115.0, 128.0, 117.0, 116.0, 119.0, 96.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 166.0, 216.0, 125.0, 160.0, 154.0, 204.0, 166.0, 123.0], "value": 159.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 198.0, 216.0, 220.0, 198.0, 199.0, 201.0, 196.0, 205.0, 198.0], "value": 202.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 80.0, 139.0, 56.0, 56.0, 56.0, 65.0, 129.0, 57.0], "value": 77.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 140.0, 110.0, 119.0, 80.0, 120.0, 79.0, 83.0, 116.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 131.0, 88.0, 85.0, 88.0, 86.0, 134.0, 119.0, 100.0, 83.0], "value": 101.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 94.0, 111.0, 152.0, 131.0, 94.0, 95.0, 95.0], "value": 105.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 96.0, 90.0, 92.0, 94.0, 89.0, 91.0, 93.0, 93.0, 95.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 62.0, 62.0, 62.0, 61.0, 61.0, 81.0, 64.0, 61.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 87.0, 59.0, 68.0, 96.0, 106.0, 98.0, 88.0, 90.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 87.0, 87.0, 109.0, 110.0, 112.0, 82.0, 88.0, 84.0], "value": 97.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 133.0, 126.0, 155.0, 146.0, 151.0, 153.0, 167.0, 259.0, 185.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 166.0, 172.0, 190.0, 232.0, 226.0, 177.0, 172.0, 180.0, 172.0], "value": 185.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 72.0, 70.0, 70.0, 68.0, 72.0, 69.0, 69.0, 68.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1619.0000000000002, "alertThreshold": 2.0}]} 04:03:46 INFO - Return code: 0 04:03:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:03:46 ERROR - # TBPL SUCCESS # 04:03:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:03:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:03:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:03:46 INFO - 2016-04-23 04:03:46.785 screenresolution[1684:10396] starting screenresolution argv=screenresolution get 04:03:46 INFO - 2016-04-23 04:03:46.787 screenresolution[1684:10396] Display 0: 1600x1200x32@60 04:03:46 INFO - 2016-04-23 04:03:46.793 screenresolution[1685:10399] starting screenresolution argv=screenresolution list 04:03:46 INFO - Available Modes on Display 0 04:03:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:03:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:03:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:03:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:03:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:03:47 INFO - Intel Iris: 04:03:47 INFO - Chipset Model: Intel Iris 04:03:47 INFO - Type: GPU 04:03:47 INFO - Bus: Built-In 04:03:47 INFO - VRAM (Dynamic, Max): 1536 MB 04:03:47 INFO - Vendor: Intel (0x8086) 04:03:47 INFO - Device ID: 0x0a2e 04:03:47 INFO - Revision ID: 0x0009 04:03:47 INFO - Displays: 04:03:47 INFO - Display: 04:03:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:03:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:03:47 INFO - Display Serial Number: 1600x1200 60 04:03:47 INFO - Main Display: Yes 04:03:47 INFO - Mirror: Off 04:03:47 INFO - Online: Yes 04:03:47 INFO - Rotation: Supported 04:03:47 INFO - Return code: 0 04:03:47 INFO - Running post-action listener: _resource_record_post_action 04:03:47 INFO - Running post-run listener: _resource_record_post_run 04:03:48 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 32603648; Write bytes: 700292096; Read time: 329; Write time: 2004 04:03:48 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 386578944; Write bytes: 383043584; Read time: 28667; Write time: 826 04:03:48 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 30821888; Write bytes: 299553792; Read time: 311; Write time: 1138 04:03:48 INFO - Running post-run listener: _upload_blobber_files 04:03:48 INFO - Blob upload gear active. 04:03:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:03:48 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:48 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:48 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:48 INFO - (blobuploader) - INFO - Open directory for files ... 04:03:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:03:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:03:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:49 INFO - (blobuploader) - INFO - Done attempting. 04:03:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:03:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:03:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:50 INFO - (blobuploader) - INFO - Done attempting. 04:03:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:03:50 INFO - Return code: 0 04:03:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:03:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:03:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b87b84bd5f126cd1783a2c94855d8e4600b0287f1589da5c90f808112cc477e418d980d2b40ea77189e713eecdf454f64b19c8969e5567a02e87e97fc7f7b2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce154595dd2c920a515bdd3dfe0c59c2f94c7894398a541b49bd8cc91e97be48fa5ae9f2110c92960f58a2ee59419844eeb7c5601c86bee5ca161af53720f681"} 04:03:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:03:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:03:50 INFO - Contents: 04:03:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b87b84bd5f126cd1783a2c94855d8e4600b0287f1589da5c90f808112cc477e418d980d2b40ea77189e713eecdf454f64b19c8969e5567a02e87e97fc7f7b2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce154595dd2c920a515bdd3dfe0c59c2f94c7894398a541b49bd8cc91e97be48fa5ae9f2110c92960f58a2ee59419844eeb7c5601c86bee5ca161af53720f681"} 04:03:50 INFO - Running post-run listener: copy_logs_to_upload_dir 04:03:50 INFO - Copying logs to upload dir... 04:03:50 INFO - mkdir: /builds/slave/test/build/upload/logs 04:03:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.557848 ========= master_lag: 9.81 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-04-23 04:04:00.427688) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 04:04:00.432091) ========= 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.nusMLK6lIi/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.dqZyZYZ5YX/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b87b84bd5f126cd1783a2c94855d8e4600b0287f1589da5c90f808112cc477e418d980d2b40ea77189e713eecdf454f64b19c8969e5567a02e87e97fc7f7b2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce154595dd2c920a515bdd3dfe0c59c2f94c7894398a541b49bd8cc91e97be48fa5ae9f2110c92960f58a2ee59419844eeb7c5601c86bee5ca161af53720f681"} 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.011089 build_url: 'https://queue.taskcluster.net/v1/task/VRc7X4jtTYOHm42I6bmtYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b87b84bd5f126cd1783a2c94855d8e4600b0287f1589da5c90f808112cc477e418d980d2b40ea77189e713eecdf454f64b19c8969e5567a02e87e97fc7f7b2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce154595dd2c920a515bdd3dfe0c59c2f94c7894398a541b49bd8cc91e97be48fa5ae9f2110c92960f58a2ee59419844eeb7c5601c86bee5ca161af53720f681"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 04:04:00.517054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2016-04-23 04:04:00.517391) ========= 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.nusMLK6lIi/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.dqZyZYZ5YX/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005155 ========= master_lag: 12.73 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2016-04-23 04:04:13.249670) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 04:04:13.249983) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 04:04:14.077397) ========= ========= Total master_lag: 22.69 =========