builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0178 starttime: 1462798445.21 results: success (0) buildid: 20160509005049 builduid: 41dbd660830c4270b4520649f25740b3 revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:05.213998) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:05.214458) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:05.214749) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:05.233046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:05.233534) ========= 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.7Pa8TT68Df/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.zdfCgPxonA/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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-05-09 05:54:05-- 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% 143M=0s 2016-05-09 05:54:05 (143 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107223 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:05.359148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:05.359472) ========= 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.7Pa8TT68Df/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.zdfCgPxonA/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.021680 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:05.410692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:05.411322) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307b5eca8726f6a72a1d69ba76630a6dbf402477 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307b5eca8726f6a72a1d69ba76630a6dbf402477 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7Pa8TT68Df/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.zdfCgPxonA/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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-05-09 05:54:05,489 truncating revision to first 12 chars 2016-05-09 05:54:05,490 Setting DEBUG logging. 2016-05-09 05:54:05,490 attempt 1/10 2016-05-09 05:54:05,490 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/307b5eca8726?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 05:54:06,212 unpacking tar archive at: mozilla-aurora-307b5eca8726/testing/mozharness/ program finished with exit code 0 elapsedTime=0.974699 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:06.407237) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:06.407801) ========= script_repo_revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:06.408442) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:06.408930) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:06.423601) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-05-09 05:54:06.423952) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7Pa8TT68Df/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.zdfCgPxonA/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:54:06 INFO - MultiFileLogger online at 20160509 05:54:06 in /builds/slave/test 05:54:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:54:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:06 INFO - {'append_to_log': False, 05:54:06 INFO - 'base_work_dir': '/builds/slave/test', 05:54:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:54:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:06 INFO - 'branch': 'Mozilla-Aurora', 05:54:06 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:06 INFO - 'config_files': ('talos/mac_config.py',), 05:54:06 INFO - 'default_actions': ('clobber', 05:54:06 INFO - 'read-buildbot-config', 05:54:06 INFO - 'download-and-extract', 05:54:06 INFO - 'populate-webroot', 05:54:06 INFO - 'create-virtualenv', 05:54:06 INFO - 'install', 05:54:06 INFO - 'run-tests'), 05:54:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:06 INFO - 'download_minidump_stackwalk': True, 05:54:06 INFO - 'download_symbols': 'ondemand', 05:54:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:06 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:06 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:06 INFO - 'installer_path': 'installer.exe', 05:54:06 INFO - 'log_level': 'info', 05:54:06 INFO - 'log_name': 'talos', 05:54:06 INFO - 'log_to_console': True, 05:54:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:54:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:54:06 INFO - 'opt_config_files': (), 05:54:06 INFO - 'pip_index': False, 05:54:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:54:06 INFO - 'cmd': ('bash', 05:54:06 INFO - '-c', 05:54:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:54:06 INFO - 'enabled': True, 05:54:06 INFO - 'halt_on_failure': False, 05:54:06 INFO - 'name': 'check_screen_resolution'},), 05:54:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:54:06 INFO - 'cmd': ('bash', 05:54:06 INFO - '-c', 05:54:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:54:06 INFO - 'enabled': True, 05:54:06 INFO - 'halt_on_failure': False, 05:54:06 INFO - 'name': 'check_screen_resolution'},), 05:54:06 INFO - 'run_cmd_checks_enabled': True, 05:54:06 INFO - 'sps_profile': False, 05:54:06 INFO - 'sps_profile_interval': 0, 05:54:06 INFO - 'suite': 'dromaeojs', 05:54:06 INFO - 'system_bits': '32', 05:54:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:06 INFO - 'title': 't-yosemite-r7-0178', 05:54:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:06 INFO - 'use_talos_json': True, 05:54:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:06 INFO - 'work_dir': 'build'} 05:54:06 INFO - ##### 05:54:06 INFO - ##### Running clobber step. 05:54:06 INFO - ##### 05:54:06 INFO - Running pre-action listener: _resource_record_pre_action 05:54:06 INFO - Running main action method: clobber 05:54:06 INFO - rmtree: /builds/slave/test/build 05:54:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:07 INFO - Running post-action listener: _resource_record_post_action 05:54:07 INFO - ##### 05:54:07 INFO - ##### Running read-buildbot-config step. 05:54:07 INFO - ##### 05:54:07 INFO - Running pre-action listener: _resource_record_pre_action 05:54:07 INFO - Running main action method: read_buildbot_config 05:54:07 INFO - Using buildbot properties: 05:54:07 INFO - { 05:54:07 INFO - "project": "", 05:54:07 INFO - "product": "firefox", 05:54:07 INFO - "script_repo_revision": "production", 05:54:07 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:54:07 INFO - "repository": "", 05:54:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:54:07 INFO - "buildid": "20160509005049", 05:54:07 INFO - "pgo_build": "False", 05:54:07 INFO - "basedir": "/builds/slave/test", 05:54:07 INFO - "buildnumber": 7, 05:54:07 INFO - "slavename": "t-yosemite-r7-0178", 05:54:07 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:54:07 INFO - "platform": "yosemite_r7", 05:54:07 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:54:07 INFO - "branch": "mozilla-aurora", 05:54:07 INFO - "repo_path": "releases/mozilla-aurora", 05:54:07 INFO - "revision": "307b5eca8726f6a72a1d69ba76630a6dbf402477", 05:54:07 INFO - "stage_platform": "macosx64", 05:54:07 INFO - "builduid": "41dbd660830c4270b4520649f25740b3", 05:54:07 INFO - "slavebuilddir": "test" 05:54:07 INFO - } 05:54:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 05:54:07 INFO - Running post-action listener: _resource_record_post_action 05:54:07 INFO - ##### 05:54:07 INFO - ##### Running download-and-extract step. 05:54:07 INFO - ##### 05:54:07 INFO - Running pre-action listener: _resource_record_pre_action 05:54:07 INFO - Running main action method: download_and_extract 05:54:07 INFO - mkdir: /builds/slave/test/build/tests 05:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:07 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:54:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 05:54:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 05:54:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 05:54:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 05:54:09 INFO - Downloaded 1199 bytes. 05:54:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 05:54:09 INFO - Using the following test package requirements: 05:54:09 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 05:54:09 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:09 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 05:54:09 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:09 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 05:54:09 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:09 INFO - u'jsshell-mac.zip'], 05:54:09 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:09 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 05:54:09 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 05:54:09 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:09 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 05:54:09 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:09 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 05:54:09 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:09 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 05:54:09 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:09 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 05:54:09 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:09 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:54:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:54:10 INFO - Downloaded 18088795 bytes. 05:54:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:54:13 INFO - Return code: 0 05:54:13 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:13 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:54:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:54:15 INFO - Downloaded 18088795 bytes. 05:54:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:54:19 INFO - Return code: 0 05:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:19 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:54:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 05:54:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 05:54:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 05:54:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:54:20 INFO - Downloaded 10840145 bytes. 05:54:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:54:20 INFO - Return code: 0 05:54: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')]} 05:54:20 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 05:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 05:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 05:54:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 05:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 05:54:24 INFO - Downloaded 114085322 bytes. 05:54:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 05:54:24 INFO - mkdir: /builds/slave/test/properties 05:54:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:24 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:24 INFO - Contents: 05:54:24 INFO - build_url:https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 05:54:26 INFO - Running post-action listener: _resource_record_post_action 05:54:26 INFO - Running post-action listener: set_extra_try_arguments 05:54:26 INFO - ##### 05:54:26 INFO - ##### Running populate-webroot step. 05:54:26 INFO - ##### 05:54:26 INFO - Running pre-action listener: _resource_record_pre_action 05:54:26 INFO - Running main action method: populate_webroot 05:54:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:26 INFO - '--tppagecycles', 05:54:26 INFO - '7'], 05:54:26 INFO - 'tests': ['tsvgm']}}, 05:54:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:54:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:54:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:54:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:54:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:54:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:26 INFO - 'talos_options': ['--disable-e10s'], 05:54:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:26 INFO - 'talos_options': ['--disable-e10s'], 05:54:26 INFO - 'tests': ['damp', 'tps']}, 05:54:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:26 INFO - 'tests': ['damp', 'tps']}, 05:54:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:54:26 INFO - 'tests': ['dromaeo_dom']}, 05:54:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:54:26 INFO - 'tests': ['a11yr', 05:54:26 INFO - 'ts_paint', 05:54:26 INFO - 'tpaint', 05:54:26 INFO - 'sessionrestore', 05:54:26 INFO - 'sessionrestore_no_auto_restore', 05:54:26 INFO - 'tabpaint']}, 05:54:26 INFO - 'other-e10s': {'tests': ['a11yr', 05:54:26 INFO - 'ts_paint', 05:54:26 INFO - 'tpaint', 05:54:26 INFO - 'sessionrestore', 05:54:26 INFO - 'sessionrestore_no_auto_restore', 05:54:26 INFO - 'tabpaint']}, 05:54:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:54:26 INFO - 'ts_paint', 05:54:26 INFO - 'tpaint', 05:54:26 INFO - 'sessionrestore', 05:54:26 INFO - 'sessionrestore_no_auto_restore', 05:54:26 INFO - 'tabpaint']}, 05:54:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:54:26 INFO - 'ts_paint', 05:54:26 INFO - 'tpaint', 05:54:26 INFO - 'sessionrestore', 05:54:26 INFO - 'sessionrestore_no_auto_restore', 05:54:26 INFO - 'tabpaint']}, 05:54:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:54:26 INFO - 'tests': ['a11yr', 05:54:26 INFO - 'ts_paint', 05:54:26 INFO - 'tpaint', 05:54:26 INFO - 'sessionrestore', 05:54:26 INFO - 'sessionrestore_no_auto_restore', 05:54:26 INFO - 'tabpaint']}, 05:54:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:54:26 INFO - 'tests': ['a11yr', 05:54:26 INFO - 'ts_paint', 05:54:26 INFO - 'tpaint', 05:54:26 INFO - 'sessionrestore', 05:54:26 INFO - 'sessionrestore_no_auto_restore', 05:54:26 INFO - 'tabpaint']}, 05:54:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:54:26 INFO - 'tests': ['tsvgx', 05:54:26 INFO - 'tsvgr_opacity', 05:54:26 INFO - 'tart', 05:54:26 INFO - 'tscrollx', 05:54:26 INFO - 'cart']}, 05:54:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:54:26 INFO - 'tsvgr_opacity', 05:54:26 INFO - 'tart', 05:54:26 INFO - 'tscrollx', 05:54:26 INFO - 'cart']}, 05:54:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:26 INFO - 'talos_options': ['--disable-e10s'], 05:54:26 INFO - 'tests': ['tp5o']}, 05:54:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:26 INFO - 'tests': ['tp5o']}, 05:54:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:26 INFO - 'talos_options': ['--disable-e10s', 05:54:26 INFO - '--xperf_path', 05:54:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:26 INFO - 'tests': ['tp5n']}, 05:54:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:26 INFO - 'talos_options': ['--xperf_path', 05:54:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:26 INFO - 'tests': ['tp5n']}}, 05:54:26 INFO - 'talos.zip': {'path': '', 05:54:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:26 INFO - Running post-action listener: _resource_record_post_action 05:54:26 INFO - ##### 05:54:26 INFO - ##### Running create-virtualenv step. 05:54:26 INFO - ##### 05:54:26 INFO - Running pre-action listener: _resource_record_pre_action 05:54:26 INFO - Running main action method: create_virtualenv 05:54:26 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:54:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:26 INFO - Using real prefix '/tools/python27' 05:54:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:54:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:30 INFO - Installing pip.................done. 05:54:30 INFO - Return code: 0 05:54:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:54: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')]} 05:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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')]} 05:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc6a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd623cbcde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baf9e00>, '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 0x10b962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baf4b20>, '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.7Pa8TT68Df/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.zdfCgPxonA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54: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', 'pip>=1.5'] in /builds/slave/test/build 05:54: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 pip>=1.5 05:54:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Pa8TT68Df/Render', 05:54:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:30 INFO - 'HOME': '/Users/cltbld', 05:54:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:30 INFO - 'LOGNAME': 'cltbld', 05:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:30 INFO - 'MOZ_NO_REMOTE': '1', 05:54:30 INFO - 'NO_EM_RESTART': '1', 05:54:30 INFO - 'PAGER': '/bin/cat', 05:54:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:30 INFO - 'PWD': '/builds/slave/test', 05:54:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:30 INFO - 'SHELL': '/bin/bash', 05:54:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdfCgPxonA/Listeners', 05:54:30 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:54:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:30 INFO - 'USER': 'cltbld', 05:54:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:30 INFO - 'XPC_FLAGS': '0x0', 05:54:30 INFO - 'XPC_SERVICE_NAME': '0', 05:54:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:54:30 INFO - Cleaning up... 05:54:30 INFO - Return code: 0 05:54:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:54: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')]} 05:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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')]} 05:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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', '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 0x10bc5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc6a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd623cbcde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baf9e00>, '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 0x10b962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baf4b20>, '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.7Pa8TT68Df/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.zdfCgPxonA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54: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', 'psutil>=0.7.1'] in /builds/slave/test/build 05:54: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 psutil>=0.7.1 05:54:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Pa8TT68Df/Render', 05:54:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:30 INFO - 'HOME': '/Users/cltbld', 05:54:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:30 INFO - 'LOGNAME': 'cltbld', 05:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:30 INFO - 'MOZ_NO_REMOTE': '1', 05:54:30 INFO - 'NO_EM_RESTART': '1', 05:54:30 INFO - 'PAGER': '/bin/cat', 05:54:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:30 INFO - 'PWD': '/builds/slave/test', 05:54:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:30 INFO - 'SHELL': '/bin/bash', 05:54:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdfCgPxonA/Listeners', 05:54:30 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:54:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:30 INFO - 'USER': 'cltbld', 05:54:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:30 INFO - 'XPC_FLAGS': '0x0', 05:54:30 INFO - 'XPC_SERVICE_NAME': '0', 05:54:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:30 INFO - Downloading/unpacking psutil>=0.7.1 05:54: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 05:54: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 05:54: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 05:54: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 05:54: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 05:54: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 05:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:33 INFO - Installing collected packages: psutil 05:54:33 INFO - Running setup.py install for psutil 05:54:33 INFO - building 'psutil._psutil_osx' extension 05:54:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:54:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:54:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:54:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:54:34 INFO - building 'psutil._psutil_posix' extension 05:54:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:54:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:54:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:54:34 INFO - ^ 05:54:34 INFO - 1 warning generated. 05:54:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:54:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:34 INFO - Successfully installed psutil 05:54:34 INFO - Cleaning up... 05:54:34 INFO - Return code: 0 05:54:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:54: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')]} 05:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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')]} 05:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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', '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 0x10bc5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc6a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd623cbcde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baf9e00>, '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 0x10b962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baf4b20>, '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.7Pa8TT68Df/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.zdfCgPxonA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:54: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 mozsystemmonitor==0.0.0 05:54:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Pa8TT68Df/Render', 05:54:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:34 INFO - 'HOME': '/Users/cltbld', 05:54:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:34 INFO - 'LOGNAME': 'cltbld', 05:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:34 INFO - 'MOZ_NO_REMOTE': '1', 05:54:34 INFO - 'NO_EM_RESTART': '1', 05:54:34 INFO - 'PAGER': '/bin/cat', 05:54:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:34 INFO - 'PWD': '/builds/slave/test', 05:54:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:34 INFO - 'SHELL': '/bin/bash', 05:54:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdfCgPxonA/Listeners', 05:54:34 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:54:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:34 INFO - 'USER': 'cltbld', 05:54:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:34 INFO - 'XPC_FLAGS': '0x0', 05:54:34 INFO - 'XPC_SERVICE_NAME': '0', 05:54:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:54: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 05:54: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 05:54: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 05:54: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 05:54: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 05:54: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 05:54:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:54:37 INFO - Installing collected packages: mozsystemmonitor 05:54:37 INFO - Running setup.py install for mozsystemmonitor 05:54:37 INFO - Successfully installed mozsystemmonitor 05:54:37 INFO - Cleaning up... 05:54:37 INFO - Return code: 0 05:54:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:37 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 0x10bc5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc6a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd623cbcde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baf9e00>, '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 0x10b962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baf4b20>, '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.7Pa8TT68Df/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.zdfCgPxonA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:54:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Pa8TT68Df/Render', 05:54:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:37 INFO - 'HOME': '/Users/cltbld', 05:54:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:37 INFO - 'LOGNAME': 'cltbld', 05:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:37 INFO - 'MOZ_NO_REMOTE': '1', 05:54:37 INFO - 'NO_EM_RESTART': '1', 05:54:37 INFO - 'PAGER': '/bin/cat', 05:54:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:37 INFO - 'PWD': '/builds/slave/test', 05:54:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:37 INFO - 'SHELL': '/bin/bash', 05:54:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdfCgPxonA/Listeners', 05:54:37 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:54:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:37 INFO - 'USER': 'cltbld', 05:54:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:37 INFO - 'XPC_FLAGS': '0x0', 05:54:37 INFO - 'XPC_SERVICE_NAME': '0', 05:54:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:37 INFO - Downloading/unpacking blobuploader==1.2.4 05:54: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 05:54: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 05:54: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 05:54: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 05:54: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 05:54: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 05:54:40 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:41 INFO - Downloading docopt-0.6.1.tar.gz 05:54:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:41 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:41 INFO - Running setup.py install for blobuploader 05:54:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:41 INFO - Running setup.py install for requests 05:54:42 INFO - Running setup.py install for docopt 05:54:42 INFO - Successfully installed blobuploader requests docopt 05:54:42 INFO - Cleaning up... 05:54:42 INFO - Return code: 0 05:54:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:42 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 0x10bc5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc6a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd623cbcde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baf9e00>, '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 0x10b962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baf4b20>, '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.7Pa8TT68Df/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.zdfCgPxonA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:54:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Pa8TT68Df/Render', 05:54:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:42 INFO - 'HOME': '/Users/cltbld', 05:54:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:42 INFO - 'LOGNAME': 'cltbld', 05:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:42 INFO - 'MOZ_NO_REMOTE': '1', 05:54:42 INFO - 'NO_EM_RESTART': '1', 05:54:42 INFO - 'PAGER': '/bin/cat', 05:54:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:42 INFO - 'PWD': '/builds/slave/test', 05:54:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:42 INFO - 'SHELL': '/bin/bash', 05:54:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdfCgPxonA/Listeners', 05:54:42 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:54:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:42 INFO - 'USER': 'cltbld', 05:54:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:42 INFO - 'XPC_FLAGS': '0x0', 05:54:42 INFO - 'XPC_SERVICE_NAME': '0', 05:54:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:42 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-l9ozsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:42 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-gK38td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:42 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-yytwzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ClHdsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-5vOokx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-yzTqI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-H6LaiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-jbWwML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-3qUsAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Q1bU1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-HekMzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-8p19Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-EitZ0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-cqp2DV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-F0Gy_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-oRNBnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-q2YGaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:44 INFO - Running setup.py install for manifestparser 05:54:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:44 INFO - Running setup.py install for mozcrash 05:54:44 INFO - Running setup.py install for mozdebug 05:54:44 INFO - Running setup.py install for mozdevice 05:54:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:54:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:45 INFO - Running setup.py install for mozfile 05:54:45 INFO - Running setup.py install for mozhttpd 05:54:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:45 INFO - Running setup.py install for mozinfo 05:54:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:45 INFO - Running setup.py install for mozInstall 05:54:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:45 INFO - Running setup.py install for mozleak 05:54:45 INFO - Running setup.py install for mozlog 05:54:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:54:45 INFO - Running setup.py install for moznetwork 05:54:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:54:46 INFO - Running setup.py install for mozprocess 05:54:46 INFO - Running setup.py install for mozprofile 05:54:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:54:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:54:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:54:46 INFO - Running setup.py install for mozrunner 05:54:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:54:46 INFO - Running setup.py install for mozscreenshot 05:54:46 INFO - Running setup.py install for moztest 05:54:46 INFO - Running setup.py install for mozversion 05:54:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:54:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:54:47 INFO - Cleaning up... 05:54:47 INFO - Return code: 0 05:54:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:47 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 0x10bc5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc6a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd623cbcde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baf9e00>, '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 0x10b962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baf4b20>, '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.7Pa8TT68Df/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.zdfCgPxonA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:54:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Pa8TT68Df/Render', 05:54:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:47 INFO - 'HOME': '/Users/cltbld', 05:54:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:47 INFO - 'LOGNAME': 'cltbld', 05:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:47 INFO - 'MOZ_NO_REMOTE': '1', 05:54:47 INFO - 'NO_EM_RESTART': '1', 05:54:47 INFO - 'PAGER': '/bin/cat', 05:54:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:47 INFO - 'PWD': '/builds/slave/test', 05:54:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:47 INFO - 'SHELL': '/bin/bash', 05:54:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdfCgPxonA/Listeners', 05:54:47 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:54:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:47 INFO - 'USER': 'cltbld', 05:54:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:47 INFO - 'XPC_FLAGS': '0x0', 05:54:47 INFO - 'XPC_SERVICE_NAME': '0', 05:54:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:47 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-rYa0K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:47 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-6Gd2d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:47 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-pPanPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:47 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-cPpogH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:47 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-yL_dhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:47 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-7SoSKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-369KpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-OgxSW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-vzL2vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-VaPvZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:48 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)) 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-C6oph2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-WLMovT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:48 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)) 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-1W_oIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-pNTayc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:48 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)) 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-qCDOQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-dBzc8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ChnExX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:51 INFO - Downloading blessings-1.6.tar.gz 05:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:54:51 INFO - Installing collected packages: blessings 05:54:51 INFO - Running setup.py install for blessings 05:54:51 INFO - Successfully installed blessings 05:54:51 INFO - Cleaning up... 05:54:52 INFO - Return code: 0 05:54:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:54:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:52 INFO - Reading from file tmpfile_stdout 05:54:52 INFO - Current package versions: 05:54:52 INFO - blessings == 1.6 05:54:52 INFO - blobuploader == 1.2.4 05:54:52 INFO - docopt == 0.6.1 05:54:52 INFO - manifestparser == 1.1 05:54:52 INFO - mozInstall == 1.12 05:54:52 INFO - mozcrash == 0.17 05:54:52 INFO - mozdebug == 0.1 05:54:52 INFO - mozdevice == 0.48 05:54:52 INFO - mozfile == 1.2 05:54:52 INFO - mozhttpd == 0.7 05:54:52 INFO - mozinfo == 0.9 05:54:52 INFO - mozleak == 0.1 05:54:52 INFO - mozlog == 3.1 05:54:52 INFO - moznetwork == 0.27 05:54:52 INFO - mozprocess == 0.22 05:54:52 INFO - mozprofile == 0.28 05:54:52 INFO - mozrunner == 6.11 05:54:52 INFO - mozscreenshot == 0.1 05:54:52 INFO - mozsystemmonitor == 0.0 05:54:52 INFO - moztest == 0.7 05:54:52 INFO - mozversion == 1.4 05:54:52 INFO - psutil == 3.1.1 05:54:52 INFO - requests == 1.2.3 05:54:52 INFO - wsgiref == 0.1.2 05:54:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:52 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 0x10bc5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc6a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd623cbcde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baf9e00>, '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 0x10b962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baf4b20>, '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.7Pa8TT68Df/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.zdfCgPxonA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:54:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Pa8TT68Df/Render', 05:54:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:52 INFO - 'HOME': '/Users/cltbld', 05:54:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:52 INFO - 'LOGNAME': 'cltbld', 05:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:52 INFO - 'MOZ_NO_REMOTE': '1', 05:54:52 INFO - 'NO_EM_RESTART': '1', 05:54:52 INFO - 'PAGER': '/bin/cat', 05:54:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:52 INFO - 'PWD': '/builds/slave/test', 05:54:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:52 INFO - 'SHELL': '/bin/bash', 05:54:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdfCgPxonA/Listeners', 05:54:52 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:54:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:52 INFO - 'USER': 'cltbld', 05:54:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:52 INFO - 'XPC_FLAGS': '0x0', 05:54:52 INFO - 'XPC_SERVICE_NAME': '0', 05:54:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:54:52 INFO - Cleaning up... 05:54:52 INFO - Return code: 0 05:54:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc6a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd623cbcde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baf9e00>, '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 0x10b962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baf4b20>, '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.7Pa8TT68Df/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.zdfCgPxonA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:54:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Pa8TT68Df/Render', 05:54:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:52 INFO - 'HOME': '/Users/cltbld', 05:54:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:52 INFO - 'LOGNAME': 'cltbld', 05:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:52 INFO - 'MOZ_NO_REMOTE': '1', 05:54:52 INFO - 'NO_EM_RESTART': '1', 05:54:52 INFO - 'PAGER': '/bin/cat', 05:54:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:52 INFO - 'PWD': '/builds/slave/test', 05:54:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:52 INFO - 'SHELL': '/bin/bash', 05:54:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdfCgPxonA/Listeners', 05:54:52 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:54:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:52 INFO - 'USER': 'cltbld', 05:54:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:52 INFO - 'XPC_FLAGS': '0x0', 05:54:52 INFO - 'XPC_SERVICE_NAME': '0', 05:54:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:52 INFO - Downloading/unpacking jsonschema 05:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:54:55 INFO - Downloading/unpacking functools32 (from jsonschema) 05:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:54:55 INFO - warning: no files found matching '*.txt' 05:54:55 INFO - no previously-included directories found matching 'build' 05:54:55 INFO - no previously-included directories found matching 'dist' 05:54:55 INFO - no previously-included directories found matching '.git*' 05:54:55 INFO - Installing collected packages: jsonschema, functools32 05:54:55 INFO - Running setup.py install for functools32 05:54:55 INFO - warning: no files found matching '*.txt' 05:54:55 INFO - no previously-included directories found matching 'build' 05:54:55 INFO - no previously-included directories found matching 'dist' 05:54:55 INFO - no previously-included directories found matching '.git*' 05:54:55 INFO - Successfully installed jsonschema functools32 05:54:55 INFO - Cleaning up... 05:54:55 INFO - Return code: 0 05:54:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:55 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 0x10bc5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc6a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd623cbcde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baf9e00>, '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 0x10b962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baf4b20>, '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.7Pa8TT68Df/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.zdfCgPxonA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:55 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 05:54:55 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 05:54:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Pa8TT68Df/Render', 05:54:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:55 INFO - 'HOME': '/Users/cltbld', 05:54:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:55 INFO - 'LOGNAME': 'cltbld', 05:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:55 INFO - 'MOZ_NO_REMOTE': '1', 05:54:55 INFO - 'NO_EM_RESTART': '1', 05:54:55 INFO - 'PAGER': '/bin/cat', 05:54:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:55 INFO - 'PWD': '/builds/slave/test', 05:54:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:55 INFO - 'SHELL': '/bin/bash', 05:54:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdfCgPxonA/Listeners', 05:54:55 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:54:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:55 INFO - 'USER': 'cltbld', 05:54:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:55 INFO - 'XPC_FLAGS': '0x0', 05:54:55 INFO - 'XPC_SERVICE_NAME': '0', 05:54:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:56 INFO - Downloading/unpacking flake8 05:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:54:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:54:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:54:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:54:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:54:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:54:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:54:59 INFO - no previously-included directories found matching 'docs/_build' 05:54:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:55:00 INFO - Running setup.py install for pep8 05:55:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:55:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:55:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:55:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:55:00 INFO - no previously-included directories found matching 'docs/_build' 05:55:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:55:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:55:00 INFO - Cleaning up... 05:55:00 INFO - Return code: 0 05:55:00 INFO - Running post-action listener: _resource_record_post_action 05:55:00 INFO - Running post-action listener: _start_resource_monitoring 05:55:00 INFO - Starting resource monitoring. 05:55:00 INFO - ##### 05:55:00 INFO - ##### Running install step. 05:55:00 INFO - ##### 05:55:00 INFO - Running pre-action listener: _resource_record_pre_action 05:55:00 INFO - Running main action method: install 05:55:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:00 INFO - Reading from file tmpfile_stdout 05:55:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:00 INFO - Reading from file tmpfile_stdout 05:55:00 INFO - Output received: 05:55:00 INFO - Usage: mozinstall [options] installer 05:55:00 INFO - Options: 05:55:00 INFO - -h, --help show this help message and exit 05:55:00 INFO - -d DEST, --destination=DEST 05:55:00 INFO - Directory to install application into. [default: 05:55:00 INFO - "/builds/slave/test"] 05:55:00 INFO - --app=APP Application being installed. [default: firefox] 05:55:00 INFO - mkdir: /builds/slave/test/build/application 05:55:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:55:31 INFO - Reading from file tmpfile_stdout 05:55:31 INFO - Output received: 05:55:31 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:55:31 INFO - Running post-action listener: _resource_record_post_action 05:55:31 INFO - ##### 05:55:31 INFO - ##### Running run-tests step. 05:55:31 INFO - ##### 05:55:31 INFO - Running pre-action listener: _resource_record_pre_action 05:55:31 INFO - Running main action method: run_tests 05:55:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:55:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:55:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:55:31 INFO - 2016-05-09 05:55:31.781 screenresolution[2223:20231] starting screenresolution argv=screenresolution get 05:55:31 INFO - 2016-05-09 05:55:31.784 screenresolution[2223:20231] Display 0: 1600x1200x32@60 05:55:31 INFO - 2016-05-09 05:55:31.790 screenresolution[2224:20234] starting screenresolution argv=screenresolution list 05:55:31 INFO - Available Modes on Display 0 05:55:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:55:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:55:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:55:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:55:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:55:32 INFO - Intel Iris: 05:55:32 INFO - Chipset Model: Intel Iris 05:55:32 INFO - Type: GPU 05:55:32 INFO - Bus: Built-In 05:55:32 INFO - VRAM (Dynamic, Max): 1536 MB 05:55:32 INFO - Vendor: Intel (0x8086) 05:55:32 INFO - Device ID: 0x0a2e 05:55:32 INFO - Revision ID: 0x0009 05:55:32 INFO - Displays: 05:55:32 INFO - Display: 05:55:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:55:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:55:32 INFO - Display Serial Number: 1600x1200 60 05:55:32 INFO - Main Display: Yes 05:55:32 INFO - Mirror: Off 05:55:32 INFO - Online: Yes 05:55:32 INFO - Rotation: Supported 05:55:32 INFO - Return code: 0 05:55:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:32 INFO - Python 2.7.3 05:55:32 INFO - Return code: 0 05:55:32 INFO - grabbing minidump binary from tooltool 05:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:32 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 0x10baf9e00>, '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 0x10b962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baf4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:55:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:55:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:32 INFO - Return code: 0 05:55:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:55:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:55:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:55:33 INFO - Return code: 0 05:55:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0178 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:55:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Pa8TT68Df/Render', 05:55:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:33 INFO - 'HOME': '/Users/cltbld', 05:55:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:33 INFO - 'LOGNAME': 'cltbld', 05:55:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:55:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:33 INFO - 'MOZ_NO_REMOTE': '1', 05:55:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:33 INFO - 'NO_EM_RESTART': '1', 05:55:33 INFO - 'PAGER': '/bin/cat', 05:55:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:33 INFO - 'PWD': '/builds/slave/test', 05:55:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:33 INFO - 'SHELL': '/bin/bash', 05:55:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdfCgPxonA/Listeners', 05:55:33 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:55:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:33 INFO - 'USER': 'cltbld', 05:55:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:33 INFO - 'XPC_FLAGS': '0x0', 05:55:33 INFO - 'XPC_SERVICE_NAME': '0', 05:55:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:55:33 INFO - mozversion application_buildid: 20160509005049 05:55:33 INFO - mozversion application_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 05:55:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:55:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:33 INFO - mozversion application_name: Firefox 05:55:33 INFO - mozversion application_remotingname: firefox-dev 05:55:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:55:33 INFO - mozversion application_vendor: Mozilla 05:55:33 INFO - mozversion application_version: 48.0a2 05:55:33 INFO - mozversion platform_buildid: 20160509005049 05:55:33 INFO - mozversion platform_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 05:55:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:55:33 INFO - mozversion platform_version: 48.0a2 05:55:33 INFO - using testdate: 1462798533 05:55:33 INFO - actual date: 1462798533 05:55:33 INFO - starting webserver on 'localhost:52682' 05:55:33 INFO - SUITE-START | Running 2 tests 05:55:33 INFO - TEST-START | dromaeo_css 05:55:33 INFO - operating with platform_type : mac_ 05:55:33 INFO - Initialising browser for dromaeo_css test... 05:55:33 INFO - TEST-INFO | started process 2242 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmp8D1qtk/profile http://localhost:52682/getInfo.html) 05:55:35 INFO - PROCESS | 2242 | __metrics Screen width/height:1600/1200 05:55:35 INFO - PROCESS | 2242 | colorDepth:24 05:55:35 INFO - PROCESS | 2242 | Browser inner width/height: 1024/689 05:55:35 INFO - PROCESS | 2242 | __metrics 05:55:35 INFO - PROCESS | 2242 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:55:35 ERROR - PROCESS | 2242 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:55:36 INFO - TEST-INFO | 2242: exit 0 05:55:36 INFO - Browser initialized. 05:55:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:36 INFO - TEST-INFO | started process 2244 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmp8D1qtk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:48 INFO - PROCESS | 2244 | RSS: Main: 211140608 05:55:48 INFO - PROCESS | 2244 | 05:56:39 INFO - PROCESS | 2244 | 1462798599684 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:58:49 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52682/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52682/tests/dromaeo/cssquery-ext.html) 05:58:51 INFO - PROCESS | 2244 | RSS: Main: 403808256 05:58:51 INFO - PROCESS | 2244 | 06:01:54 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52682/tests/dromaeo/cssquery-ext.html (next: http://localhost:52682/tests/dromaeo/cssquery-jquery.html) 06:01:55 INFO - PROCESS | 2244 | RSS: Main: 361603072 06:01:55 INFO - PROCESS | 2244 | 06:04:57 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52682/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52682/tests/dromaeo/cssquery-mootools.html) 06:04:58 INFO - PROCESS | 2244 | RSS: Main: 362061824 06:04:58 INFO - PROCESS | 2244 | 06:08:00 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52682/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52682/tests/dromaeo/cssquery-prototype.html) 06:08:01 INFO - PROCESS | 2244 | RSS: Main: 363450368 06:08:01 INFO - PROCESS | 2244 | 06:11:04 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52682/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52682/tests/dromaeo/cssquery-yui.html) 06:11:04 INFO - PROCESS | 2244 | RSS: Main: 331837440 06:11:04 INFO - PROCESS | 2244 | 06:14:07 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52682/tests/dromaeo/cssquery-yui.html (next: http://localhost:52682/tests/dromaeo/cssquery-dojo.html) 06:14:07 INFO - PROCESS | 2244 | RSS: Main: 369053696 06:14:07 INFO - PROCESS | 2244 | 06:14:07 INFO - PROCESS | 2244 | __start_tp_report 06:14:07 INFO - PROCESS | 2244 | _x_x_mozilla_page_load 06:14:07 INFO - PROCESS | 2244 | _x_x_mozilla_page_load_details 06:14:07 INFO - PROCESS | 2244 | |i|pagename|runs| 06:14:07 INFO - PROCESS | 2244 | |0;dojo.html;3097.5198844179154;3408.4205685033558;3409.590849098108;3446.5691788526433;3458.962311306609;5669.376368599456;5686.971565142174;5689;5689.288838895138;5697.829065128042;5643.746031428585;5686.232358631583;5687.687177205252;5696.515796157331;5697.088465845465;5114.872128196787;5158.432572417031;5187.662801917863;5249.396319423277;5267.631265811395;5248.737563121847;5262.000219958215;5267.55225805807;5271.710055946922;5272.973635131819;5192.974035129819;5250.133727934886;5260.579153667716;5265.3155089838265;5277.8944421111555;5243.449437809013;5255.921161182585;5285.6300058995885;5297.17893726473;5311.123664595337;5105.642605017651;5108.106081435771;5119.976004799055;5187.8184263550975;5203.947960520422;5033.723145227011;5258.368995720538;5565.916511252334;5631.9718401408145;5654.37801841797;5706.801571669955;5722.599418040739;6250.562460627758;6263.4362907338555;6263.906041409383;6120.418560236771;6182.258129024546;6287.7170527325925;6289.213848268966;6301.432871041582;5765.365809760923;5772.076467765221;5788.710564471844;5791.015527360401;5811.099279611667;6274.529410294246;6284.402981716729;6289.371062893674;6300.27546832111;6300.905486417708;6000.0999850022845;6096.573239873166;6097.725602347905;6150.384961503813;6171.876562468726;6238.064290356483;6244.937550624436;6254.280757712831;6269.749210031548;6272.780452684134;6157.538184636171;6212.4408803207025;6218.409251121137;6223.813285601349;6234.875302494015;6075.635461872302;6138.265785110792;6141.486007784275;6158.199434073631;6234.470070044097;4879.585235255043;4937.679050861682;4940.8764780880765;4966.404031516241;4981.028699403654;4389.1660584488845;4398.186335527937;4402.3836662867225;4402.427684401007;4434.689571729948;5550.972245138749;5631.971840140773;5636.436356364331;5648.51987581052;5688.260526131577;6126.326104128542;6174.413430724074;6242.812715618538;6281.842953926189;6283.874322513524;5645.887082258332;5657.15142728594;5662.207290979266;5664.943350566524;5666;5305.681659100466;5401.432849550819;5402.000629883484;5402.37872644643;5413.269208656781;6253.499720022387;6253.7185826637915;6291.748330066746;6294.055891616111;6342.587731797418;6194.752209911553;6228.408301211378;6248.937510624835;6268.122462855295;6268.247810262797;6341.207349081365;6360.840978975562;6371.585846919936;6376.458001069961;6388.361163883575;6030.246219222598;6135.509159267337;6145.4161854623735;6179;6207.131001659862;6131.713108457373;6227.595206311576;6240.032794916795;6242.500599952084;6251.343608920998;5975.462208401264;6052.818415447544;6070.332263450929;6087.543434242361;6091.177691011657;5873.4126587342635;5952.196453478899;5959.195508606283;6087.543434242538;6096.725647345791;5862.296524417097;5895.14520394549;5896.764129434775;5908.3205431375945;5922.822315330547;5973.253343332083;5973.352409907889;6017.458428741259;6023.879522409615;6036.6679832609625;4930.827421040246;5849.912251316318;5871.383504732113;5925.674087925206;5974.551908606959 06:14:07 INFO - PROCESS | 2244 | |1;ext.html;518.1605798606258;526.4656373780613;529.6451377577023;549.2447884159283;563.0006738039976;31326.68673313269;32020.519692204605;38964.61035389649;39643.207135857265;39909.60316388927;42663.36004959928;43114.35328470075;43231;43253.35119973195;43437.39375637464;9308.394954327981;9541.2367010639;9543.618255269781;9545.761355966088;9549;8433.831323373559;8722.738317850475;11417;11607.883921160765;11608.187426880122;11329.830052549218;11409.600663976762;11412.429378531082;11458.770824583504;11473.655790326304;8458.407911446202;11287.37919414432;11378.146639002067;11386.71533211668;11441.771164576745;11324.716882077932;11446.484908179069;11449.885501144965;11460.255083419552;11477.253978491455;38929.61070389288;39384.409233861516;39415.60584394148;39456.80271598652;39481.40777888334;3177.1104090854597;3246.3345014272018;3264.7388208943225;3284.9835750821094;3298.818564978925;28068.719312806814;29253.829846806104;29564.113076607737;29591.70408295911;29671.25821854449;2752.5320695481814;2758.7930905182193;2778.402643431672;2793.20393687798;2824.350399408127;422766;423667.8816605897;425676;426093;427786;63633.36366636367;63905;64313;64404.67797661076;64424.677876610316;68219;69427.95858062133;69499.3050069503;69541;69597.65201174063;17622.559436014202;17829;17853.196606152753;17862.19620117098;17874.910625446788;12544.560940367044;12785.808212876815;13324.866751332556;13439.126456780474;13485.66285842842;19270.90364548168;19299.166579174955;19333.323333683536;19347.226110955686;19360.515987100436;6454.935450645527;7611.200823913409;7676.462647614613;7709.884351734729;7772.455928085093;965.7440778193784;991.7520619845038;1052.310736467615;1070.4808168038496;1081.113486940701;29597.55603665947;30044.699553004626;30235;30877.536836947464;31051.75792968301;1091.4160923905672;1108.817045187535;1153.371412580146;1168;1183.721825371037;14966.925165374103;15222.238888055554;15332.386704531917;15576.987495812737;15650.37398504047;602941;612708;621491;621791.8910405509;622211;60184.39815601875;61053.08420373698;61075.38924610697;61150.69424652848;61209.69395153085;1327.396034804181;1436.8922330825021;1478.7116512280218;1487.8288996765511;1491.9850801491846;28938.27654308659;29300.267493312836;29323.26691832636;29580.415035669506;30052.398952021274;48032;48048;48333.75833120812;48336.5166348332;48337;366569;371233;373678;374258;374389;22016.669749954082;23863;26656.733432665424;26939.730602694508;27921;43238.78380608077;43333.3499997494;44515.77742111269;44727.552724473644;44880;34497.827510862284;35170.82414588013;36285;37070.629293707796;37089.44365834461;35569;36209;36498.8175059123;36865.44701829421;37935.43096853494;36567.817160914026;37080.62919370772;37558.06104847291;37707.81146094252;37864.43203351897;31256.68743312538;33256.667433325354;33258.168545786546;33319.83340083284;33446.66553334533;24241.90911409026;24650.383740406633;24683.876580616983;25181.49637007213;25321.366965826 06:14:07 INFO - PROCESS | 2244 | |2;jquery.html;326.3243245932139;343.9982800086;418.04685317476145;420.8653230966092;425.93185090385504;19259.422217333486;20437.386878393634;20783.16867325307;20867.373978780623;20883.060262288196;11815.113866460008;12333;20966.89516552419;21405;21499.67750483744;5411.107167317397;5550.500454959053;5598.692071936062;5611.989841828469;5615.943840561583;4039.272930872442;4239.703220774547;5929.792457263997;6201.565890387675;6221.3156552779155;6182.165407669952;6189;6193.256809182904;6196.38036196379;6239.594426362272;6861.897071543931;6871.209810871764;6886.208086070116;6888.380045795878;6908.309169083102;3915.549711783153;5763.798267060674;6025;6026.96986515069;6031.336552979169;13736.587902362846;13857.722845543134;13875.722485550334;25086.121985730413;25831.74168258331;2191.80273775361;2240.9215677451375;2344.3787396339812;2422.188566830114;2784.955641634387;8571.785705357415;9655.420674759467;10001.949990250076;10133.935936726612;10530.842037369446;1723.1039859273108;1740.2951804519064;1762.030883014337;1764.8676349273856;1781.714925611896;115994;117524.82475175224;119716.80283197231;120241.39879300722;120480;11771.88228117725;11781.941090294493;11789.292642441482;11802.350870702194;11822.704432389259;15487.612809679622;15522.689546209238;15553.766693499607;15554;15558.833087518482;9026.684066057787;9046.547672616343;9047.457152570867;9155;9203.953980230055;9034.277257819358;9034.638614455349;9056.547172641342;9070.365074444726;9137.862932056025;4315.352697095461;4704.29435584665;4783;4792.675552357104;4811.037792441526;1679.6472740724585;1779.4006839390372;1913.9904300478688;2012.265523084093;2012.7182194492782;908.4413085952092;929.9352241683234;962.6919385796618;972.1445128287204;1042.5621239079605;19192.616147676967;19845.00774961246;20724.481887952923;20958.89520552418;21181.894090529448;967.0764419978904;988.1847475832467;991.2862738828177;998.6454808543008;999.0459111548454;10951.288166269167;11045.447727613748;11205.383703896201;11228.214025018171;11245.493952772145;511949;581778;591901;591963;606415;95074.0492595079;120741;126884;127403;130860.69139308676;1042.2652030318607;1054.0513537816028;1064.446487826326;1068.6526878764432;1071.2019545438698;18289.817101828812;18697.626047479247;18752.6249475007;18927.242910283436;19172.13725382389;52847.47152528579;54361.45638543564;54529.45470545244;54763;55003.449965499836;72542.63728681323;75253;75889.24110758821;77309.84035239363;77324.61337693276;7650.4644674872225;8265.338772898274;8374.413791034569;8532.274756645755;8776.122387761172;12106.152569320064;12130.75738485243;12616.55842045524;13017.804732929204;13038.934805325913;10749.731256718645;11062.668119956414;11208.49561769706;11375.829362559403;11560.248583842023;9350.859737103812;11071.003609675168;11074.335539867634;11269.943650281695;11566.826497602711;11387.43062846871;11471.311721296748;11527.962483376536;11549.538018479167;11605.129615278718;8046.235607617267;8285.817608972402;8473.279771219515;8623.956880215559;8873.91126088731;9825.508724563886;10976.560937562408;11277.154213433862;11358.26171298863;11447.313161210353 06:14:07 INFO - PROCESS | 2244 | |3;mootools.html;1373.0320124312361;1517.3930427828868;1571.5756745678666;1774.6983012887808;1910.4650697804611;7910.802229944247;8569.314454843614;8715.694950676727;8726.1710137537;8733.301335893122;8466.534340611264;8657.13428657134;8691.56542172892;8694.21752042316;8694.652213911451;2454.1533171056003;2482.6524286599893;2486.415692312314;2486.7761901428867;2489.128804918282;2380.1193558383334;2449.301948944551;2456.201734436306;2457.2382561405934;2466.839655422401;2438.183208625113;2468.049800826677;2480.6651102101164;2483.1060818105466;2490.22802931091;2436.1717016214484;2469.6665950096776;2480.913168039119;2481.2184161988916;2485.515324511721;2431.76898194673;2480.441900572375;2481.664975228357;2482.2801387597574;2486.9751302487107;8424.326053915673;8668.479891206485;8680;8705.303575713991;8752.387332886701;5395.4604539545735;5582.692951887645;5584.6090773645865;5584.748686309126;5586;3520.3839328117733;3631.782093074424;3631.94552081719;3659.9268014639824;3665.5234819473562;1020.5968642386216;1053.1416895230439;1054.1198099586854;1057.5558265528496;1077.21363404715;11749.883761042687;11850.88149118515;11854.229475084092;11867.050635949103;11900.702482437922;4005.4592629994577;4578.198815207325;4719.693219940693;4720.858374248778;4752.833650822205;9354.812903741888;9375.01562335945;9376.296777741696;9379.343445958717;9412;5302.734863256822;5311.336082989626;5314.62797604164;5329.094054010828;5334.119870221448;4383.452068491439;4554.726716397026;4759.857204283877;4840.080384726891;4945.9258111128365;3852.5745474174173;3868.419737039467;3963.6630886374983;3967.7222594418113;3974.880753577397;1219.5487669562142;1227.061298106949;1230.846144231971;1242.782513060211;1245.725940293134;819.8278361544023;850.3282406898481;851.7061613743249;906.8594367872859;919.72868003939;5572.192032155314;5665.348484924204;5670.914936275959;5855.268091488564;5916.201312822714;1008.8890222075565;1009.6920439265947;1019.3985548526257;1035.3839465518004;1058.8358804385332;3676.191237927652;3685.8894233173046;3764.322421964018;3796.449514820391;3842.769433833979;10416.21878359111;10585.735356615993;10884.836727449094;10904.018638322588;10916.563337466412;10729;10737.78524429507;10740.838887416696;10752.892471075345;10923.235373523778;8354.62404191825;8415.747527574182;8549.743507694655;8561.82876342482;8572.057073721886;5498.642588231752;5543.972280138573;5642.520385767091;5664.745086471036;5704.971475142764;9619.27855410833;9728.659496917573;9841.065098815601;9920.255980801325;9925.454100024568;9426.293028023063;10007.54966026516;10174.847377289494;10176.982301769764;10203.234757393077;5683.829485115453;6464.450521705519;6633.170853643294;7092.6099064551945;7181.138263408425;8129.837403251783;8366.498010119412;8442.32461403074;8457.238848503664;8465.619047143016;7351.485396022227;7463.925360746323;7464.514806537558;7602.771916842504;7610;7324.340809327186;7328.120625524971;7392.963035185005;7401.703931842666;7418.666160022704;7050.682719277543;7054;7086.362227399559;7090.432765378654;7092.645367731696;4697.436307643105;4780.8247247502995;4804.111239420718;4829;4871.123197824284;4771.95228047715;4810.63920205993;4855.5387238212315;4869.537393947569;5063.3417655704525 06:14:07 INFO - PROCESS | 2244 | |4;prototype.html;297.6770204328304;321.5129079444642;322.2748815165877;330.96359400465946;332.04868053028065;5372.489613486718;6462.9353706462925;6561.98289265164;6673.966630166842;6676.432503237231;6596.96701516493;6597.043428702836;6610.669466526667;6616.536842421033;6620.801375958729;4666.416697912761;4779.354787103749;4816.7350795706225;4841.176999910023;4864.854054378375;4783.904321913559;4847.272909063633;4851.951480485185;4893.681910675812;4917.262410638397;3984.5417776955733;4742.596879265267;4805.20714082176;4821.059893320804;4822.951770482286;4561.589456948874;4635.605973492257;4829.082474329866;4836.661433699643;4841.782119804618;4092.4884389451317;4161.583841615845;4162.2299874523005;4172.436721042681;4181.247375472413;6188;6233.750649973996;6258;6312;6320.62076275425;4599.425071866017;5713.885722285572;5724.771009159628;5725.2843394575675;5734.283214598176;6359.618422894595;6949.339812717783;6955.339242771928;6962.547434416797;6971.128608923885;4364.738115713036;4646.95353046472;4657.60410365116;4680.531946805292;4686.507916668769;7384.15082265541;7396.963015184943;7458.776236712907;7461.589612571306;7483.775486735407;4644.303354496852;4653.302004699322;4656.790444429941;4657.371254880548;4658.650601204923;4733.266343716729;4734.053189362141;4737.952620473751;4738.4550776660435;4743.620510359163;5603.915941260884;5623.775048998076;5627.380988091307;5629.4652008059165;5630.5495560355075;5775.249217601685;6797.320267973262;7052.047973523611;7092.255313192144;7095.574265544084;1604.2299696145683;1615.668787898478;1630.8124565674862;1633.085472135608;1636.2718590227473;1016.9644062457926;1025.2976710953021;1041.3023274406166;1043.7808060307268;1046.5970601318395;5295.914337560791;5489.725513724298;6574.967125164344;6598.47212223021;6729.596224226562;7389.926100738924;7396.704131834666;7400.407967362598;7403.074615673041;7414.814629634302;5414.35027796667;6679.365460281266;6681.899771503431;6681.966590167115;6686.899696504556;3475.6792418880664;3570.1967057412394;3910.4329872168946;3913.471681323042;3914.197589494147;7467.3652739516665;7764.184760600056;7780.805479863048;7798.337141342936;7802.102758182768;7593.164751877289;7623.656935437919;7642.388608911274;7651.923480765121;7652.808679782938;6219.440250377488;7747.070351557849;7762.922370776333;7770.417218708506;7772.145064043064;7365.153007404003;7378.557286562824;7380.96309518449;7388.519746216479;7397.889031664422;6974.337437943387;7239.565626062453;7250.746223882139;7255.129384473686;7264.673089711081;7666.655000524878;7711.8843217352905;7722.111957125003;7725.188855170126;7730.304272615492;4656.604188644003;4660.300954856799;4662.417197850269;4665.440147182359;4665.5567721066445;7347;7349.742759003409;7355.154157271768;7363.8159046024275;7363.963180184279;6072.876517844213;6318.589291696025;7100.964495177491;7141.642917853983;7152.678129484081;5731.8567035824435;5857.4435428634215;6223.190985171898;6638.672265547007;7093.82265443368;6859.279775623488;6969.059177011039;6970.302969702989;6977.476689248225;6984.965075174591;6827.965860170667;7077.893831592427;7087.184973728087;7092.822679433056;7094.432445404252;6659.7003134860015;6830.59016459014;6947.65261736901;6979.4765392594745;6991.405730512964 06:14:07 INFO - PROCESS | 2244 | |5;yui.html;713.7252157919202;743.8884167374894;757.5381005875391;769.5228958046013;804.7706403674952;14724.852751472483;14826.925865370671;15104.093754374746;15159.469418570352;15217.315220815062;13956.092853964485;13995.230262335568;14040.64898377541;14041.087329323613;14049.157050576972;748.5658318175446;765.8391737735054;922.0410772796283;925.4169872980013;949.2738055387634;939.1453777062874;950.1543626172712;953.4041224234853;954.813811306792;955.0497255231055;986.5018165826248;1003.282652903174;1003.5634498992962;1006.3509036671343;1006.3810756384808;772.9565087132382;973.0172525748974;1003.2525768302588;1006.0191313469383;1008.4554340656036;733.7248531800575;733.9376153026999;737.8966944627756;738.8337624034602;739.2570466680951;14678.559643210721;14730.926345368312;14741.778873316909;14746.926265368711;14754.483593074297;12410.255384676948;12430.751384972249;12750.681232969157;12807.61577152687;12862;8764;10037;10047.949760251153;10104.797904041878;10946.726331841688;3510.2102027043966;3580.534530511043;3614.7288953328343;3680.7607505512324;3682.852685892561;76551.85172222421;76614.99999999945;76625.46749064987;76685;76843.61578192073;9506.144446999802;9564.282678799118;9569.234461243084;9600.183984361407;9722.513874306256;21912;22021.33935981923;22051.889740551196;22343.77656223417;22367.10531578751;7474.850502990019;7476.925230747623;7623.885641715378;7763.378929685611;7773.611319434006;4050.6354428101613;4065.918681626351;4109.712320137562;4259.148170365939;4331.610155086058;3488.930221395558;3528.8059156746626;3601.603823579404;3603.0992251937014;3658.4512323151207;571.5227784799656;617.478230894893;675.9391654751096;680.7413182990432;683.4498228925663;498.82042464712674;531.912234481314;581.5434883616341;620.7299824576323;625.4746013348717;7897.802554936057;8083.636236369378;8100.918990810134;8188.672453101809;8191.139930307232;553.5543887170866;571.8313097636208;591.030709636197;618.0636335951037;627.6736097229415;3769.1896242308035;3803.8478460861256;3813.3517302058717;3930.705197110171;3940.8817735467983;88494;92623.5368823165;92716;93039;93294.53352733194;57031.42968570261;73322.9001564977;74688;75754.24245757582;76284.9999999989;66091.67816643737;68080.97878531826;68603.999999999;69118.30881691119;69729.65135174291;7488;7548.094228692592;7672.73145439907;7835.255650713173;7878.054633444023;37386;48663;48945.75527122342;49005.75497122492;49072;53623.46376536185;62691.43271418251;65560;70755;71577.64211178912;10781.784364312827;11010.614628487965;11232.719182020515;11234.662960111209;11391.772164556496;11831.250530902273;11970.461329240032;12002.579909703118;12268.570600028956;12654.050946179257;10921.235513513977;11100.777984440427;11326.546938122712;11375.829362559403;11745.236559623598;11139.944300278446;11460.656180314603;11461.828072578752;11481.82777258325;12307.461567304086;11001.61494347726;11207.551697931991;11227.607033753779;11433.771324573629;11460.541578336773;9332.39339442934;9685.17675997548;9803.11548081918;9836.163926066365;9913.801723965624;8493.745187644381;9535.141837234682;9589.376690515093;9595;9612.951935240279 06:14:07 INFO - PROCESS | 2244 | __end_tp_report 06:14:07 INFO - PROCESS | 2244 | __start_cc_report 06:14:07 INFO - PROCESS | 2244 | _x_x_mozilla_cycle_collect,1876 06:14:07 INFO - PROCESS | 2244 | __end_cc_report 06:14:07 INFO - PROCESS | 2244 | __startTimestamp1462799647921__endTimestamp 06:14:07 INFO - PROCESS | 2244 | 06:14:07 INFO - PROCESS | 2244 | ------- Summary: start ------- 06:14:07 INFO - PROCESS | 2244 | Number of tests: 6 06:14:07 INFO - PROCESS | 2244 | 06:14:07 INFO - PROCESS | 2244 | [#0] dojo.html Cycles:165 Average:5712.93 Median:5895.15 stddev:634.85 (10.8%) stddev-sans-first:602.73 06:14:07 INFO - PROCESS | 2244 | Values: 3097.5 3408.4 3409.6 3446.6 3459.0 5669.4 5687.0 5689.0 5689.3 5697.8 5643.7 5686.2 5687.7 5696.5 5697.1 5114.9 5158.4 5187.7 5249.4 5267.6 5248.7 5262.0 5267.6 5271.7 5273.0 5193.0 5250.1 5260.6 5265.3 5277.9 5243.4 5255.9 5285.6 5297.2 5311.1 5105.6 5108.1 5120.0 5187.8 5203.9 5033.7 5258.4 5565.9 5632.0 5654.4 5706.8 5722.6 6250.6 6263.4 6263.9 6120.4 6182.3 6287.7 6289.2 6301.4 5765.4 5772.1 5788.7 5791.0 5811.1 6274.5 6284.4 6289.4 6300.3 6300.9 6000.1 6096.6 6097.7 6150.4 6171.9 6238.1 6244.9 6254.3 6269.7 6272.8 6157.5 6212.4 6218.4 6223.8 6234.9 6075.6 6138.3 6141.5 6158.2 6234.5 4879.6 4937.7 4940.9 4966.4 4981.0 4389.2 4398.2 4402.4 4402.4 4434.7 5551.0 5632.0 5636.4 5648.5 5688.3 6126.3 6174.4 6242.8 6281.8 6283.9 5645.9 5657.2 5662.2 5664.9 5666.0 5305.7 5401.4 5402.0 5402.4 5413.3 6253.5 6253.7 6291.7 6294.1 6342.6 6194.8 6228.4 6248.9 6268.1 6268.2 6341.2 6360.8 6371.6 6376.5 6388.4 6030.2 6135.5 6145.4 6179.0 6207.1 6131.7 6227.6 6240.0 6242.5 6251.3 5975.5 6052.8 6070.3 6087.5 6091.2 5873.4 5952.2 5959.2 6087.5 6096.7 5862.3 5895.1 5896.8 5908.3 5922.8 5973.3 5973.4 6017.5 6023.9 6036.7 4930.8 5849.9 5871.4 5925.7 5974.6 06:14:07 INFO - PROCESS | 2244 | 06:14:07 INFO - PROCESS | 2244 | [#1] ext.html Cycles:180 Average:62164.90 Median:33383.25 stddev:128627.59 (385.3%) stddev-sans-first:128905.15 06:14:07 INFO - PROCESS | 2244 | Values: 518.2 526.5 529.6 549.2 563.0 31326.7 32020.5 38964.6 39643.2 39909.6 42663.4 43114.4 43231.0 43253.4 43437.4 9308.4 9541.2 9543.6 9545.8 9549.0 8433.8 8722.7 11417.0 11607.9 11608.2 11329.8 11409.6 11412.4 11458.8 11473.7 8458.4 11287.4 11378.1 11386.7 11441.8 11324.7 11446.5 11449.9 11460.3 11477.3 38929.6 39384.4 39415.6 39456.8 39481.4 3177.1 3246.3 3264.7 3285.0 3298.8 28068.7 29253.8 29564.1 29591.7 29671.3 2752.5 2758.8 2778.4 2793.2 2824.4 422766.0 423667.9 425676.0 426093.0 427786.0 63633.4 63905.0 64313.0 64404.7 64424.7 68219.0 69428.0 69499.3 69541.0 69597.7 17622.6 17829.0 17853.2 17862.2 17874.9 12544.6 12785.8 13324.9 13439.1 13485.7 19270.9 19299.2 19333.3 19347.2 19360.5 6454.9 7611.2 7676.5 7709.9 7772.5 965.7 991.8 1052.3 1070.5 1081.1 29597.6 30044.7 30235.0 30877.5 31051.8 1091.4 1108.8 1153.4 1168.0 1183.7 14966.9 15222.2 15332.4 15577.0 15650.4 602941.0 612708.0 621491.0 621791.9 622211.0 60184.4 61053.1 61075.4 61150.7 61209.7 1327.4 1436.9 1478.7 1487.8 1492.0 28938.3 29300.3 29323.3 29580.4 30052.4 48032.0 48048.0 48333.8 48336.5 48337.0 366569.0 371233.0 373678.0 374258.0 374389.0 22016.7 23863.0 26656.7 26939.7 27921.0 43238.8 43333.3 44515.8 44727.6 44880.0 34497.8 35170.8 36285.0 37070.6 37089.4 35569.0 36209.0 36498.8 36865.4 37935.4 36567.8 37080.6 37558.1 37707.8 37864.4 31256.7 33256.7 33258.2 33319.8 33446.7 24241.9 24650.4 24683.9 25181.5 25321.4 06:14:07 INFO - PROCESS | 2244 | 06:14:07 INFO - PROCESS | 2244 | [#2] jquery.html Cycles:180 Average:34038.01 Median:2292.65 stddev:96471.01 (4207.8%) stddev-sans-first:96708.43 06:14:07 INFO - PROCESS | 2244 | Values: 326.3 344.0 418.0 420.9 425.9 19259.4 20437.4 20783.2 20867.4 20883.1 11815.1 12333.0 20966.9 21405.0 21499.7 5411.1 5550.5 5598.7 5612.0 5615.9 4039.3 4239.7 5929.8 6201.6 6221.3 6182.2 6189.0 6193.3 6196.4 6239.6 6861.9 6871.2 6886.2 6888.4 6908.3 3915.5 5763.8 6025.0 6027.0 6031.3 13736.6 13857.7 13875.7 25086.1 25831.7 2191.8 2240.9 2344.4 2422.2 2785.0 8571.8 9655.4 10001.9 10133.9 10530.8 1723.1 1740.3 1762.0 1764.9 1781.7 115994.0 117524.8 119716.8 120241.4 120480.0 11771.9 11781.9 11789.3 11802.4 11822.7 15487.6 15522.7 15553.8 15554.0 15558.8 9026.7 9046.5 9047.5 9155.0 9204.0 9034.3 9034.6 9056.5 9070.4 9137.9 4315.4 4704.3 4783.0 4792.7 4811.0 1679.6 1779.4 1914.0 2012.3 2012.7 908.4 929.9 962.7 972.1 1042.6 19192.6 19845.0 20724.5 20958.9 21181.9 967.1 988.2 991.3 998.6 999.0 10951.3 11045.4 11205.4 11228.2 11245.5 511949.0 581778.0 591901.0 591963.0 606415.0 95074.0 120741.0 126884.0 127403.0 130860.7 1042.3 1054.1 1064.4 1068.7 1071.2 18289.8 18697.6 18752.6 18927.2 19172.1 52847.5 54361.5 54529.5 54763.0 55003.4 72542.6 75253.0 75889.2 77309.8 77324.6 7650.5 8265.3 8374.4 8532.3 8776.1 12106.2 12130.8 12616.6 13017.8 13038.9 10749.7 11062.7 11208.5 11375.8 11560.2 9350.9 11071.0 11074.3 11269.9 11566.8 11387.4 11471.3 11528.0 11549.5 11605.1 8046.2 8285.8 8473.3 8624.0 8873.9 9825.5 10976.6 11277.2 11358.3 11447.3 06:14:07 INFO - PROCESS | 2244 | 06:14:07 INFO - PROCESS | 2244 | [#3] mootools.html Cycles:180 Average:5676.93 Median:4807.38 stddev:3164.18 (65.8%) stddev-sans-first:3156.52 06:14:07 INFO - PROCESS | 2244 | Values: 1373.0 1517.4 1571.6 1774.7 1910.5 7910.8 8569.3 8715.7 8726.2 8733.3 8466.5 8657.1 8691.6 8694.2 8694.7 2454.2 2482.7 2486.4 2486.8 2489.1 2380.1 2449.3 2456.2 2457.2 2466.8 2438.2 2468.0 2480.7 2483.1 2490.2 2436.2 2469.7 2480.9 2481.2 2485.5 2431.8 2480.4 2481.7 2482.3 2487.0 8424.3 8668.5 8680.0 8705.3 8752.4 5395.5 5582.7 5584.6 5584.7 5586.0 3520.4 3631.8 3631.9 3659.9 3665.5 1020.6 1053.1 1054.1 1057.6 1077.2 11749.9 11850.9 11854.2 11867.1 11900.7 4005.5 4578.2 4719.7 4720.9 4752.8 9354.8 9375.0 9376.3 9379.3 9412.0 5302.7 5311.3 5314.6 5329.1 5334.1 4383.5 4554.7 4759.9 4840.1 4945.9 3852.6 3868.4 3963.7 3967.7 3974.9 1219.5 1227.1 1230.8 1242.8 1245.7 819.8 850.3 851.7 906.9 919.7 5572.2 5665.3 5670.9 5855.3 5916.2 1008.9 1009.7 1019.4 1035.4 1058.8 3676.2 3685.9 3764.3 3796.4 3842.8 10416.2 10585.7 10884.8 10904.0 10916.6 10729.0 10737.8 10740.8 10752.9 10923.2 8354.6 8415.7 8549.7 8561.8 8572.1 5498.6 5544.0 5642.5 5664.7 5705.0 9619.3 9728.7 9841.1 9920.3 9925.5 9426.3 10007.5 10174.8 10177.0 10203.2 5683.8 6464.5 6633.2 7092.6 7181.1 8129.8 8366.5 8442.3 8457.2 8465.6 7351.5 7463.9 7464.5 7602.8 7610.0 7324.3 7328.1 7393.0 7401.7 7418.7 7050.7 7054.0 7086.4 7090.4 7092.6 4697.4 4780.8 4804.1 4829.0 4871.1 4772.0 4810.6 4855.5 4869.5 5063.3 06:14:07 INFO - PROCESS | 2244 | 06:14:07 INFO - PROCESS | 2244 | [#4] prototype.html Cycles:180 Average:5731.17 Median:6340.12 stddev:1857.20 (29.3%) stddev-sans-first:1817.08 06:14:07 INFO - PROCESS | 2244 | Values: 297.7 321.5 322.3 331.0 332.0 5372.5 6462.9 6562.0 6674.0 6676.4 6597.0 6597.0 6610.7 6616.5 6620.8 4666.4 4779.4 4816.7 4841.2 4864.9 4783.9 4847.3 4852.0 4893.7 4917.3 3984.5 4742.6 4805.2 4821.1 4823.0 4561.6 4635.6 4829.1 4836.7 4841.8 4092.5 4161.6 4162.2 4172.4 4181.2 6188.0 6233.8 6258.0 6312.0 6320.6 4599.4 5713.9 5724.8 5725.3 5734.3 6359.6 6949.3 6955.3 6962.5 6971.1 4364.7 4647.0 4657.6 4680.5 4686.5 7384.2 7397.0 7458.8 7461.6 7483.8 4644.3 4653.3 4656.8 4657.4 4658.7 4733.3 4734.1 4738.0 4738.5 4743.6 5603.9 5623.8 5627.4 5629.5 5630.5 5775.2 6797.3 7052.0 7092.3 7095.6 1604.2 1615.7 1630.8 1633.1 1636.3 1017.0 1025.3 1041.3 1043.8 1046.6 5295.9 5489.7 6575.0 6598.5 6729.6 7389.9 7396.7 7400.4 7403.1 7414.8 5414.4 6679.4 6681.9 6682.0 6686.9 3475.7 3570.2 3910.4 3913.5 3914.2 7467.4 7764.2 7780.8 7798.3 7802.1 7593.2 7623.7 7642.4 7651.9 7652.8 6219.4 7747.1 7762.9 7770.4 7772.1 7365.2 7378.6 7381.0 7388.5 7397.9 6974.3 7239.6 7250.7 7255.1 7264.7 7666.7 7711.9 7722.1 7725.2 7730.3 4656.6 4660.3 4662.4 4665.4 4665.6 7347.0 7349.7 7355.2 7363.8 7364.0 6072.9 6318.6 7101.0 7141.6 7152.7 5731.9 5857.4 6223.2 6638.7 7093.8 6859.3 6969.1 6970.3 6977.5 6985.0 6828.0 7077.9 7087.2 7092.8 7094.4 6659.7 6830.6 6947.7 6979.5 6991.4 06:14:07 INFO - PROCESS | 2244 | 06:14:07 INFO - PROCESS | 2244 | [#5] yui.html Cycles:180 Average:17782.60 Median:28801.48 stddev:24677.05 (85.7%) stddev-sans-first:24712.99 06:14:07 INFO - PROCESS | 2244 | Values: 713.7 743.9 757.5 769.5 804.8 14724.9 14826.9 15104.1 15159.5 15217.3 13956.1 13995.2 14040.6 14041.1 14049.2 748.6 765.8 922.0 925.4 949.3 939.1 950.2 953.4 954.8 955.0 986.5 1003.3 1003.6 1006.4 1006.4 773.0 973.0 1003.3 1006.0 1008.5 733.7 733.9 737.9 738.8 739.3 14678.6 14730.9 14741.8 14746.9 14754.5 12410.3 12430.8 12750.7 12807.6 12862.0 8764.0 10037.0 10047.9 10104.8 10946.7 3510.2 3580.5 3614.7 3680.8 3682.9 76551.9 76615.0 76625.5 76685.0 76843.6 9506.1 9564.3 9569.2 9600.2 9722.5 21912.0 22021.3 22051.9 22343.8 22367.1 7474.9 7476.9 7623.9 7763.4 7773.6 4050.6 4065.9 4109.7 4259.1 4331.6 3488.9 3528.8 3601.6 3603.1 3658.5 571.5 617.5 675.9 680.7 683.4 498.8 531.9 581.5 620.7 625.5 7897.8 8083.6 8100.9 8188.7 8191.1 553.6 571.8 591.0 618.1 627.7 3769.2 3803.8 3813.4 3930.7 3940.9 88494.0 92623.5 92716.0 93039.0 93294.5 57031.4 73322.9 74688.0 75754.2 76285.0 66091.7 68081.0 68604.0 69118.3 69729.7 7488.0 7548.1 7672.7 7835.3 7878.1 37386.0 48663.0 48945.8 49005.8 49072.0 53623.5 62691.4 65560.0 70755.0 71577.6 10781.8 11010.6 11232.7 11234.7 11391.8 11831.3 11970.5 12002.6 12268.6 12654.1 10921.2 11100.8 11326.5 11375.8 11745.2 11139.9 11460.7 11461.8 11481.8 12307.5 11001.6 11207.6 11227.6 11433.8 11460.5 9332.4 9685.2 9803.1 9836.2 9913.8 8493.7 9535.1 9589.4 9595.0 9613.0 06:14:07 INFO - PROCESS | 2244 | -------- Summary: end -------- 06:14:07 INFO - PROCESS | 2244 | 06:14:08 INFO - TEST-INFO | 2244: exit 0 06:14:08 INFO - TEST-OK | dromaeo_css | took 1115096ms 06:14:08 INFO - TEST-START | kraken 06:14:08 INFO - operating with platform_type : mac_ 06:14:08 INFO - Initialising browser for kraken test... 06:14:08 INFO - TEST-INFO | started process 2246 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpqA1tRX/profile http://localhost:52682/getInfo.html) 06:14:10 INFO - PROCESS | 2246 | __metrics Screen width/height:1600/1200 06:14:10 INFO - PROCESS | 2246 | colorDepth:24 06:14:10 INFO - PROCESS | 2246 | Browser inner width/height: 1024/689 06:14:10 INFO - PROCESS | 2246 | __metrics 06:14:10 INFO - PROCESS | 2246 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:14:10 ERROR - PROCESS | 2246 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:14:11 INFO - TEST-INFO | 2246: exit 0 06:14:11 INFO - Browser initialized. 06:14:11 INFO - Running cycle 1/1 for kraken test... 06:14:11 INFO - TEST-INFO | started process 2248 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpqA1tRX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:23 INFO - PROCESS | 2248 | RSS: Main: 211169280 06:14:23 INFO - PROCESS | 2248 | 06:14:25 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52682/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:26 INFO - PROCESS | 2248 | RSS: Main: 271855616 06:14:26 INFO - PROCESS | 2248 | 06:14:29 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52682/tests/kraken/driver.html?testName=audio-dft) 06:14:30 INFO - PROCESS | 2248 | RSS: Main: 286240768 06:14:30 INFO - PROCESS | 2248 | 06:14:33 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52682/tests/kraken/driver.html?testName=audio-fft) 06:14:33 INFO - PROCESS | 2248 | RSS: Main: 375042048 06:14:33 INFO - PROCESS | 2248 | 06:14:35 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52682/tests/kraken/driver.html?testName=audio-oscillator) 06:14:36 INFO - PROCESS | 2248 | RSS: Main: 278843392 06:14:36 INFO - PROCESS | 2248 | 06:14:38 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52682/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:39 INFO - PROCESS | 2248 | RSS: Main: 280002560 06:14:39 INFO - PROCESS | 2248 | 06:14:42 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52682/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:42 INFO - PROCESS | 2248 | RSS: Main: 317702144 06:14:42 INFO - PROCESS | 2248 | 06:14:45 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52682/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:46 INFO - PROCESS | 2248 | RSS: Main: 317906944 06:14:46 INFO - PROCESS | 2248 | 06:14:48 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52682/tests/kraken/driver.html?testName=json-parse-financial) 06:14:49 INFO - PROCESS | 2248 | RSS: Main: 315006976 06:14:49 INFO - PROCESS | 2248 | 06:14:51 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52682/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:51 INFO - PROCESS | 2248 | RSS: Main: 309645312 06:14:51 INFO - PROCESS | 2248 | 06:14:53 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:54 INFO - PROCESS | 2248 | RSS: Main: 315965440 06:14:54 INFO - PROCESS | 2248 | 06:14:56 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:57 INFO - PROCESS | 2248 | RSS: Main: 319012864 06:14:57 INFO - PROCESS | 2248 | 06:14:59 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:15:00 INFO - PROCESS | 2248 | RSS: Main: 323829760 06:15:00 INFO - PROCESS | 2248 | 06:15:03 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:15:04 INFO - PROCESS | 2248 | RSS: Main: 322187264 06:15:04 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52682/tests/kraken/driver.html?testName=ai-astar) 06:15:05 INFO - PROCESS | 2248 | RSS: Main: 386457600 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | __start_tp_report 06:15:05 INFO - PROCESS | 2248 | _x_x_mozilla_page_load 06:15:05 INFO - PROCESS | 2248 | _x_x_mozilla_page_load_details 06:15:05 INFO - PROCESS | 2248 | |i|pagename|runs| 06:15:05 INFO - PROCESS | 2248 | |0;ai-astar;114;114;119;112;113;112;114;114;114;135 06:15:05 INFO - PROCESS | 2248 | |1;audio-beat-detection;159;125;156;155;115;142;141;118;169;118 06:15:05 INFO - PROCESS | 2248 | |2;audio-dft;186;188;187;187;188;184;186;187;182;183 06:15:05 INFO - PROCESS | 2248 | |3;audio-fft;75;98;107;190;56;54;56;63;132;55 06:15:05 INFO - PROCESS | 2248 | |4;audio-oscillator;96;95;143;76;80;80;127;80;106;169 06:15:05 INFO - PROCESS | 2248 | |5;imaging-gaussian-blur;87;85;87;83;87;83;87;85;90;86 06:15:05 INFO - PROCESS | 2248 | |6;imaging-darkroom;92;95;97;93;92;92;100;91;92;93 06:15:05 INFO - PROCESS | 2248 | |7;imaging-desaturate;86;86;87;85;85;85;83;85;99;133 06:15:05 INFO - PROCESS | 2248 | |8;json-parse-financial;61;62;65;63;63;63;65;82;58;58 06:15:05 INFO - PROCESS | 2248 | |9;json-stringify-tinderbox;63;65;67;81;76;72;70;70;71;71 06:15:05 INFO - PROCESS | 2248 | |10;stanford-crypto-aes;82;81;81;81;80;80;81;80;82;84 06:15:05 INFO - PROCESS | 2248 | |11;stanford-crypto-ccm;143;147;147;129;127;125;130;129;152;134 06:15:05 INFO - PROCESS | 2248 | |12;stanford-crypto-pbkdf2;185;215;187;163;170;169;167;155;165;164 06:15:05 INFO - PROCESS | 2248 | |13;stanford-crypto-sha256-iterative;68;68;67;68;69;68;66;68;66;67 06:15:05 INFO - PROCESS | 2248 | __end_tp_report 06:15:05 INFO - PROCESS | 2248 | __start_cc_report 06:15:05 INFO - PROCESS | 2248 | _x_x_mozilla_cycle_collect,2058 06:15:05 INFO - PROCESS | 2248 | __end_cc_report 06:15:05 INFO - PROCESS | 2248 | __startTimestamp1462799705973__endTimestamp 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | ------- Summary: start ------- 06:15:05 INFO - PROCESS | 2248 | Number of tests: 14 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | [#0] ai-astar Cycles:10 Average:116.10 Median:114.00 stddev:6.92 (6.1%) stddev-sans-first:7.30 06:15:05 INFO - PROCESS | 2248 | Values: 114.0 114.0 119.0 112.0 113.0 112.0 114.0 114.0 114.0 135.0 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:148.50 stddev:19.74 (13.3%) stddev-sans-first:19.67 06:15:05 INFO - PROCESS | 2248 | Values: 159.0 125.0 156.0 155.0 115.0 142.0 141.0 118.0 169.0 118.0 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | [#2] audio-dft Cycles:10 Average:185.80 Median:187.00 stddev:2.10 (1.1%) stddev-sans-first:2.22 06:15:05 INFO - PROCESS | 2248 | Values: 186.0 188.0 187.0 187.0 188.0 184.0 186.0 187.0 182.0 183.0 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | [#3] audio-fft Cycles:10 Average:88.60 Median:56.00 stddev:44.58 (79.6%) stddev-sans-first:47.01 06:15:05 INFO - PROCESS | 2248 | Values: 75.0 98.0 107.0 190.0 56.0 54.0 56.0 63.0 132.0 55.0 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:80.00 stddev:31.48 (39.4%) stddev-sans-first:33.22 06:15:05 INFO - PROCESS | 2248 | Values: 96.0 95.0 143.0 76.0 80.0 80.0 127.0 80.0 106.0 169.0 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:87.00 stddev:2.11 (2.4%) stddev-sans-first:2.20 06:15:05 INFO - PROCESS | 2248 | Values: 87.0 85.0 87.0 83.0 87.0 83.0 87.0 85.0 90.0 86.0 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:92.50 stddev:2.83 (3.1%) stddev-sans-first:2.93 06:15:05 INFO - PROCESS | 2248 | Values: 92.0 95.0 97.0 93.0 92.0 92.0 100.0 91.0 92.0 93.0 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | [#7] imaging-desaturate Cycles:10 Average:91.40 Median:85.50 stddev:15.28 (17.9%) stddev-sans-first:16.08 06:15:05 INFO - PROCESS | 2248 | Values: 86.0 86.0 87.0 85.0 85.0 85.0 83.0 85.0 99.0 133.0 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:63.00 stddev:6.78 (10.8%) stddev-sans-first:7.11 06:15:05 INFO - PROCESS | 2248 | Values: 61.0 62.0 65.0 63.0 63.0 63.0 65.0 82.0 58.0 58.0 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:5.19 (7.3%) stddev-sans-first:4.72 06:15:05 INFO - PROCESS | 2248 | Values: 63.0 65.0 67.0 81.0 76.0 72.0 70.0 70.0 71.0 71.0 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:1.23 (1.5%) stddev-sans-first:1.27 06:15:05 INFO - PROCESS | 2248 | Values: 82.0 81.0 81.0 81.0 80.0 80.0 81.0 80.0 82.0 84.0 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:138.50 stddev:9.92 (7.2%) stddev-sans-first:10.22 06:15:05 INFO - PROCESS | 2248 | Values: 143.0 147.0 147.0 129.0 127.0 125.0 130.0 129.0 152.0 134.0 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:169.50 stddev:17.40 (10.3%) stddev-sans-first:17.99 06:15:05 INFO - PROCESS | 2248 | Values: 185.0 215.0 187.0 163.0 170.0 169.0 167.0 155.0 165.0 164.0 06:15:05 INFO - PROCESS | 2248 | 06:15:05 INFO - PROCESS | 2248 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 06:15:05 INFO - PROCESS | 2248 | Values: 68.0 68.0 67.0 68.0 69.0 68.0 66.0 68.0 66.0 67.0 06:15:05 INFO - PROCESS | 2248 | -------- Summary: end -------- 06:15:05 INFO - PROCESS | 2248 | 06:15:06 INFO - TEST-INFO | 2248: exit 0 06:15:06 INFO - TEST-OK | kraken | took 58225ms 06:15:06 INFO - SUITE-END | took 1173s 06:15:07 INFO - Completed test suite (00:19:33) 06:15:07 INFO - javascript benchmark 06:15:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.5198844179154, 3408.4205685033558, 3409.590849098108, 3446.5691788526433, 3458.962311306609, 5669.376368599456, 5686.971565142174, 5689.0, 5689.288838895138, 5697.829065128042, 5643.746031428585, 5686.232358631583, 5687.687177205252, 5696.515796157331, 5697.088465845465, 5114.872128196787, 5158.432572417031, 5187.662801917863, 5249.396319423277, 5267.631265811395, 5248.737563121847, 5262.000219958215, 5267.55225805807, 5271.710055946922, 5272.973635131819, 5192.974035129819, 5250.133727934886, 5260.579153667716, 5265.3155089838265, 5277.8944421111555, 5243.449437809013, 5255.921161182585, 5285.6300058995885, 5297.17893726473, 5311.123664595337, 5105.642605017651, 5108.106081435771, 5119.976004799055, 5187.8184263550975, 5203.947960520422, 5033.723145227011, 5258.368995720538, 5565.916511252334, 5631.9718401408145, 5654.37801841797, 5706.801571669955, 5722.599418040739, 6250.562460627758, 6263.4362907338555, 6263.906041409383, 6120.418560236771, 6182.258129024546, 6287.7170527325925, 6289.213848268966, 6301.432871041582, 5765.365809760923, 5772.076467765221, 5788.710564471844, 5791.015527360401, 5811.099279611667, 6274.529410294246, 6284.402981716729, 6289.371062893674, 6300.27546832111, 6300.905486417708, 6000.0999850022845, 6096.573239873166, 6097.725602347905, 6150.384961503813, 6171.876562468726, 6238.064290356483, 6244.937550624436, 6254.280757712831, 6269.749210031548, 6272.780452684134, 6157.538184636171, 6212.4408803207025, 6218.409251121137, 6223.813285601349, 6234.875302494015, 6075.635461872302, 6138.265785110792, 6141.486007784275, 6158.199434073631, 6234.470070044097, 4879.585235255043, 4937.679050861682, 4940.8764780880765, 4966.404031516241, 4981.028699403654, 4389.1660584488845, 4398.186335527937, 4402.3836662867225, 4402.427684401007, 4434.689571729948, 5550.972245138749, 5631.971840140773, 5636.436356364331, 5648.51987581052, 5688.260526131577, 6126.326104128542, 6174.413430724074, 6242.812715618538, 6281.842953926189, 6283.874322513524, 5645.887082258332, 5657.15142728594, 5662.207290979266, 5664.943350566524, 5666.0, 5305.681659100466, 5401.432849550819, 5402.000629883484, 5402.37872644643, 5413.269208656781, 6253.499720022387, 6253.7185826637915, 6291.748330066746, 6294.055891616111, 6342.587731797418, 6194.752209911553, 6228.408301211378, 6248.937510624835, 6268.122462855295, 6268.247810262797, 6341.207349081365, 6360.840978975562, 6371.585846919936, 6376.458001069961, 6388.361163883575, 6030.246219222598, 6135.509159267337, 6145.4161854623735, 6179.0, 6207.131001659862, 6131.713108457373, 6227.595206311576, 6240.032794916795, 6242.500599952084, 6251.343608920998, 5975.462208401264, 6052.818415447544, 6070.332263450929, 6087.543434242361, 6091.177691011657, 5873.4126587342635, 5952.196453478899, 5959.195508606283, 6087.543434242538, 6096.725647345791, 5862.296524417097, 5895.14520394549, 5896.764129434775, 5908.3205431375945, 5922.822315330547, 5973.253343332083, 5973.352409907889, 6017.458428741259, 6023.879522409615, 6036.6679832609625, 4930.827421040246, 5849.912251316318, 5871.383504732113, 5925.674087925206, 5974.551908606959], "value": 5672.406654189755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.1605798606258, 526.4656373780613, 529.6451377577023, 549.2447884159283, 563.0006738039976, 31326.68673313269, 32020.519692204605, 38964.61035389649, 39643.207135857265, 39909.60316388927, 42663.36004959928, 43114.35328470075, 43231.0, 43253.35119973195, 43437.39375637464, 9308.394954327981, 9541.2367010639, 9543.618255269781, 9545.761355966088, 9549.0, 8433.831323373559, 8722.738317850475, 11417.0, 11607.883921160765, 11608.187426880122, 11329.830052549218, 11409.600663976762, 11412.429378531082, 11458.770824583504, 11473.655790326304, 8458.407911446202, 11287.37919414432, 11378.146639002067, 11386.71533211668, 11441.771164576745, 11324.716882077932, 11446.484908179069, 11449.885501144965, 11460.255083419552, 11477.253978491455, 38929.61070389288, 39384.409233861516, 39415.60584394148, 39456.80271598652, 39481.40777888334, 3177.1104090854597, 3246.3345014272018, 3264.7388208943225, 3284.9835750821094, 3298.818564978925, 28068.719312806814, 29253.829846806104, 29564.113076607737, 29591.70408295911, 29671.25821854449, 2752.5320695481814, 2758.7930905182193, 2778.402643431672, 2793.20393687798, 2824.350399408127, 422766.0, 423667.8816605897, 425676.0, 426093.0, 427786.0, 63633.36366636367, 63905.0, 64313.0, 64404.67797661076, 64424.677876610316, 68219.0, 69427.95858062133, 69499.3050069503, 69541.0, 69597.65201174063, 17622.559436014202, 17829.0, 17853.196606152753, 17862.19620117098, 17874.910625446788, 12544.560940367044, 12785.808212876815, 13324.866751332556, 13439.126456780474, 13485.66285842842, 19270.90364548168, 19299.166579174955, 19333.323333683536, 19347.226110955686, 19360.515987100436, 6454.935450645527, 7611.200823913409, 7676.462647614613, 7709.884351734729, 7772.455928085093, 965.7440778193784, 991.7520619845038, 1052.310736467615, 1070.4808168038496, 1081.113486940701, 29597.55603665947, 30044.699553004626, 30235.0, 30877.536836947464, 31051.75792968301, 1091.4160923905672, 1108.817045187535, 1153.371412580146, 1168.0, 1183.721825371037, 14966.925165374103, 15222.238888055554, 15332.386704531917, 15576.987495812737, 15650.37398504047, 602941.0, 612708.0, 621491.0, 621791.8910405509, 622211.0, 60184.39815601875, 61053.08420373698, 61075.38924610697, 61150.69424652848, 61209.69395153085, 1327.396034804181, 1436.8922330825021, 1478.7116512280218, 1487.8288996765511, 1491.9850801491846, 28938.27654308659, 29300.267493312836, 29323.26691832636, 29580.415035669506, 30052.398952021274, 48032.0, 48048.0, 48333.75833120812, 48336.5166348332, 48337.0, 366569.0, 371233.0, 373678.0, 374258.0, 374389.0, 22016.669749954082, 23863.0, 26656.733432665424, 26939.730602694508, 27921.0, 43238.78380608077, 43333.3499997494, 44515.77742111269, 44727.552724473644, 44880.0, 34497.827510862284, 35170.82414588013, 36285.0, 37070.629293707796, 37089.44365834461, 35569.0, 36209.0, 36498.8175059123, 36865.44701829421, 37935.43096853494, 36567.817160914026, 37080.62919370772, 37558.06104847291, 37707.81146094252, 37864.43203351897, 31256.68743312538, 33256.667433325354, 33258.168545786546, 33319.83340083284, 33446.66553334533, 24241.90911409026, 24650.383740406633, 24683.876580616983, 25181.49637007213, 25321.366965826], "value": 19878.10004471718, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.3243245932139, 343.9982800086, 418.04685317476145, 420.8653230966092, 425.93185090385504, 19259.422217333486, 20437.386878393634, 20783.16867325307, 20867.373978780623, 20883.060262288196, 11815.113866460008, 12333.0, 20966.89516552419, 21405.0, 21499.67750483744, 5411.107167317397, 5550.500454959053, 5598.692071936062, 5611.989841828469, 5615.943840561583, 4039.272930872442, 4239.703220774547, 5929.792457263997, 6201.565890387675, 6221.3156552779155, 6182.165407669952, 6189.0, 6193.256809182904, 6196.38036196379, 6239.594426362272, 6861.897071543931, 6871.209810871764, 6886.208086070116, 6888.380045795878, 6908.309169083102, 3915.549711783153, 5763.798267060674, 6025.0, 6026.96986515069, 6031.336552979169, 13736.587902362846, 13857.722845543134, 13875.722485550334, 25086.121985730413, 25831.74168258331, 2191.80273775361, 2240.9215677451375, 2344.3787396339812, 2422.188566830114, 2784.955641634387, 8571.785705357415, 9655.420674759467, 10001.949990250076, 10133.935936726612, 10530.842037369446, 1723.1039859273108, 1740.2951804519064, 1762.030883014337, 1764.8676349273856, 1781.714925611896, 115994.0, 117524.82475175224, 119716.80283197231, 120241.39879300722, 120480.0, 11771.88228117725, 11781.941090294493, 11789.292642441482, 11802.350870702194, 11822.704432389259, 15487.612809679622, 15522.689546209238, 15553.766693499607, 15554.0, 15558.833087518482, 9026.684066057787, 9046.547672616343, 9047.457152570867, 9155.0, 9203.953980230055, 9034.277257819358, 9034.638614455349, 9056.547172641342, 9070.365074444726, 9137.862932056025, 4315.352697095461, 4704.29435584665, 4783.0, 4792.675552357104, 4811.037792441526, 1679.6472740724585, 1779.4006839390372, 1913.9904300478688, 2012.265523084093, 2012.7182194492782, 908.4413085952092, 929.9352241683234, 962.6919385796618, 972.1445128287204, 1042.5621239079605, 19192.616147676967, 19845.00774961246, 20724.481887952923, 20958.89520552418, 21181.894090529448, 967.0764419978904, 988.1847475832467, 991.2862738828177, 998.6454808543008, 999.0459111548454, 10951.288166269167, 11045.447727613748, 11205.383703896201, 11228.214025018171, 11245.493952772145, 511949.0, 581778.0, 591901.0, 591963.0, 606415.0, 95074.0492595079, 120741.0, 126884.0, 127403.0, 130860.69139308676, 1042.2652030318607, 1054.0513537816028, 1064.446487826326, 1068.6526878764432, 1071.2019545438698, 18289.817101828812, 18697.626047479247, 18752.6249475007, 18927.242910283436, 19172.13725382389, 52847.47152528579, 54361.45638543564, 54529.45470545244, 54763.0, 55003.449965499836, 72542.63728681323, 75253.0, 75889.24110758821, 77309.84035239363, 77324.61337693276, 7650.4644674872225, 8265.338772898274, 8374.413791034569, 8532.274756645755, 8776.122387761172, 12106.152569320064, 12130.75738485243, 12616.55842045524, 13017.804732929204, 13038.934805325913, 10749.731256718645, 11062.668119956414, 11208.49561769706, 11375.829362559403, 11560.248583842023, 9350.859737103812, 11071.003609675168, 11074.335539867634, 11269.943650281695, 11566.826497602711, 11387.43062846871, 11471.311721296748, 11527.962483376536, 11549.538018479167, 11605.129615278718, 8046.235607617267, 8285.817608972402, 8473.279771219515, 8623.956880215559, 8873.91126088731, 9825.508724563886, 10976.560937562408, 11277.154213433862, 11358.26171298863, 11447.313161210353], "value": 9558.220610432805, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.0320124312361, 1517.3930427828868, 1571.5756745678666, 1774.6983012887808, 1910.4650697804611, 7910.802229944247, 8569.314454843614, 8715.694950676727, 8726.1710137537, 8733.301335893122, 8466.534340611264, 8657.13428657134, 8691.56542172892, 8694.21752042316, 8694.652213911451, 2454.1533171056003, 2482.6524286599893, 2486.415692312314, 2486.7761901428867, 2489.128804918282, 2380.1193558383334, 2449.301948944551, 2456.201734436306, 2457.2382561405934, 2466.839655422401, 2438.183208625113, 2468.049800826677, 2480.6651102101164, 2483.1060818105466, 2490.22802931091, 2436.1717016214484, 2469.6665950096776, 2480.913168039119, 2481.2184161988916, 2485.515324511721, 2431.76898194673, 2480.441900572375, 2481.664975228357, 2482.2801387597574, 2486.9751302487107, 8424.326053915673, 8668.479891206485, 8680.0, 8705.303575713991, 8752.387332886701, 5395.4604539545735, 5582.692951887645, 5584.6090773645865, 5584.748686309126, 5586.0, 3520.3839328117733, 3631.782093074424, 3631.94552081719, 3659.9268014639824, 3665.5234819473562, 1020.5968642386216, 1053.1416895230439, 1054.1198099586854, 1057.5558265528496, 1077.21363404715, 11749.883761042687, 11850.88149118515, 11854.229475084092, 11867.050635949103, 11900.702482437922, 4005.4592629994577, 4578.198815207325, 4719.693219940693, 4720.858374248778, 4752.833650822205, 9354.812903741888, 9375.01562335945, 9376.296777741696, 9379.343445958717, 9412.0, 5302.734863256822, 5311.336082989626, 5314.62797604164, 5329.094054010828, 5334.119870221448, 4383.452068491439, 4554.726716397026, 4759.857204283877, 4840.080384726891, 4945.9258111128365, 3852.5745474174173, 3868.419737039467, 3963.6630886374983, 3967.7222594418113, 3974.880753577397, 1219.5487669562142, 1227.061298106949, 1230.846144231971, 1242.782513060211, 1245.725940293134, 819.8278361544023, 850.3282406898481, 851.7061613743249, 906.8594367872859, 919.72868003939, 5572.192032155314, 5665.348484924204, 5670.914936275959, 5855.268091488564, 5916.201312822714, 1008.8890222075565, 1009.6920439265947, 1019.3985548526257, 1035.3839465518004, 1058.8358804385332, 3676.191237927652, 3685.8894233173046, 3764.322421964018, 3796.449514820391, 3842.769433833979, 10416.21878359111, 10585.735356615993, 10884.836727449094, 10904.018638322588, 10916.563337466412, 10729.0, 10737.78524429507, 10740.838887416696, 10752.892471075345, 10923.235373523778, 8354.62404191825, 8415.747527574182, 8549.743507694655, 8561.82876342482, 8572.057073721886, 5498.642588231752, 5543.972280138573, 5642.520385767091, 5664.745086471036, 5704.971475142764, 9619.27855410833, 9728.659496917573, 9841.065098815601, 9920.255980801325, 9925.454100024568, 9426.293028023063, 10007.54966026516, 10174.847377289494, 10176.982301769764, 10203.234757393077, 5683.829485115453, 6464.450521705519, 6633.170853643294, 7092.6099064551945, 7181.138263408425, 8129.837403251783, 8366.498010119412, 8442.32461403074, 8457.238848503664, 8465.619047143016, 7351.485396022227, 7463.925360746323, 7464.514806537558, 7602.771916842504, 7610.0, 7324.340809327186, 7328.120625524971, 7392.963035185005, 7401.703931842666, 7418.666160022704, 7050.682719277543, 7054.0, 7086.362227399559, 7090.432765378654, 7092.645367731696, 4697.436307643105, 4780.8247247502995, 4804.111239420718, 4829.0, 4871.123197824284, 4771.95228047715, 4810.63920205993, 4855.5387238212315, 4869.537393947569, 5063.3417655704525], "value": 4586.0225167935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.6770204328304, 321.5129079444642, 322.2748815165877, 330.96359400465946, 332.04868053028065, 5372.489613486718, 6462.9353706462925, 6561.98289265164, 6673.966630166842, 6676.432503237231, 6596.96701516493, 6597.043428702836, 6610.669466526667, 6616.536842421033, 6620.801375958729, 4666.416697912761, 4779.354787103749, 4816.7350795706225, 4841.176999910023, 4864.854054378375, 4783.904321913559, 4847.272909063633, 4851.951480485185, 4893.681910675812, 4917.262410638397, 3984.5417776955733, 4742.596879265267, 4805.20714082176, 4821.059893320804, 4822.951770482286, 4561.589456948874, 4635.605973492257, 4829.082474329866, 4836.661433699643, 4841.782119804618, 4092.4884389451317, 4161.583841615845, 4162.2299874523005, 4172.436721042681, 4181.247375472413, 6188.0, 6233.750649973996, 6258.0, 6312.0, 6320.62076275425, 4599.425071866017, 5713.885722285572, 5724.771009159628, 5725.2843394575675, 5734.283214598176, 6359.618422894595, 6949.339812717783, 6955.339242771928, 6962.547434416797, 6971.128608923885, 4364.738115713036, 4646.95353046472, 4657.60410365116, 4680.531946805292, 4686.507916668769, 7384.15082265541, 7396.963015184943, 7458.776236712907, 7461.589612571306, 7483.775486735407, 4644.303354496852, 4653.302004699322, 4656.790444429941, 4657.371254880548, 4658.650601204923, 4733.266343716729, 4734.053189362141, 4737.952620473751, 4738.4550776660435, 4743.620510359163, 5603.915941260884, 5623.775048998076, 5627.380988091307, 5629.4652008059165, 5630.5495560355075, 5775.249217601685, 6797.320267973262, 7052.047973523611, 7092.255313192144, 7095.574265544084, 1604.2299696145683, 1615.668787898478, 1630.8124565674862, 1633.085472135608, 1636.2718590227473, 1016.9644062457926, 1025.2976710953021, 1041.3023274406166, 1043.7808060307268, 1046.5970601318395, 5295.914337560791, 5489.725513724298, 6574.967125164344, 6598.47212223021, 6729.596224226562, 7389.926100738924, 7396.704131834666, 7400.407967362598, 7403.074615673041, 7414.814629634302, 5414.35027796667, 6679.365460281266, 6681.899771503431, 6681.966590167115, 6686.899696504556, 3475.6792418880664, 3570.1967057412394, 3910.4329872168946, 3913.471681323042, 3914.197589494147, 7467.3652739516665, 7764.184760600056, 7780.805479863048, 7798.337141342936, 7802.102758182768, 7593.164751877289, 7623.656935437919, 7642.388608911274, 7651.923480765121, 7652.808679782938, 6219.440250377488, 7747.070351557849, 7762.922370776333, 7770.417218708506, 7772.145064043064, 7365.153007404003, 7378.557286562824, 7380.96309518449, 7388.519746216479, 7397.889031664422, 6974.337437943387, 7239.565626062453, 7250.746223882139, 7255.129384473686, 7264.673089711081, 7666.655000524878, 7711.8843217352905, 7722.111957125003, 7725.188855170126, 7730.304272615492, 4656.604188644003, 4660.300954856799, 4662.417197850269, 4665.440147182359, 4665.5567721066445, 7347.0, 7349.742759003409, 7355.154157271768, 7363.8159046024275, 7363.963180184279, 6072.876517844213, 6318.589291696025, 7100.964495177491, 7141.642917853983, 7152.678129484081, 5731.8567035824435, 5857.4435428634215, 6223.190985171898, 6638.672265547007, 7093.82265443368, 6859.279775623488, 6969.059177011039, 6970.302969702989, 6977.476689248225, 6984.965075174591, 6827.965860170667, 7077.893831592427, 7087.184973728087, 7092.822679433056, 7094.432445404252, 6659.7003134860015, 6830.59016459014, 6947.65261736901, 6979.4765392594745, 6991.405730512964], "value": 5109.535349169264, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.7252157919202, 743.8884167374894, 757.5381005875391, 769.5228958046013, 804.7706403674952, 14724.852751472483, 14826.925865370671, 15104.093754374746, 15159.469418570352, 15217.315220815062, 13956.092853964485, 13995.230262335568, 14040.64898377541, 14041.087329323613, 14049.157050576972, 748.5658318175446, 765.8391737735054, 922.0410772796283, 925.4169872980013, 949.2738055387634, 939.1453777062874, 950.1543626172712, 953.4041224234853, 954.813811306792, 955.0497255231055, 986.5018165826248, 1003.282652903174, 1003.5634498992962, 1006.3509036671343, 1006.3810756384808, 772.9565087132382, 973.0172525748974, 1003.2525768302588, 1006.0191313469383, 1008.4554340656036, 733.7248531800575, 733.9376153026999, 737.8966944627756, 738.8337624034602, 739.2570466680951, 14678.559643210721, 14730.926345368312, 14741.778873316909, 14746.926265368711, 14754.483593074297, 12410.255384676948, 12430.751384972249, 12750.681232969157, 12807.61577152687, 12862.0, 8764.0, 10037.0, 10047.949760251153, 10104.797904041878, 10946.726331841688, 3510.2102027043966, 3580.534530511043, 3614.7288953328343, 3680.7607505512324, 3682.852685892561, 76551.85172222421, 76614.99999999945, 76625.46749064987, 76685.0, 76843.61578192073, 9506.144446999802, 9564.282678799118, 9569.234461243084, 9600.183984361407, 9722.513874306256, 21912.0, 22021.33935981923, 22051.889740551196, 22343.77656223417, 22367.10531578751, 7474.850502990019, 7476.925230747623, 7623.885641715378, 7763.378929685611, 7773.611319434006, 4050.6354428101613, 4065.918681626351, 4109.712320137562, 4259.148170365939, 4331.610155086058, 3488.930221395558, 3528.8059156746626, 3601.603823579404, 3603.0992251937014, 3658.4512323151207, 571.5227784799656, 617.478230894893, 675.9391654751096, 680.7413182990432, 683.4498228925663, 498.82042464712674, 531.912234481314, 581.5434883616341, 620.7299824576323, 625.4746013348717, 7897.802554936057, 8083.636236369378, 8100.918990810134, 8188.672453101809, 8191.139930307232, 553.5543887170866, 571.8313097636208, 591.030709636197, 618.0636335951037, 627.6736097229415, 3769.1896242308035, 3803.8478460861256, 3813.3517302058717, 3930.705197110171, 3940.8817735467983, 88494.0, 92623.5368823165, 92716.0, 93039.0, 93294.53352733194, 57031.42968570261, 73322.9001564977, 74688.0, 75754.24245757582, 76284.9999999989, 66091.67816643737, 68080.97878531826, 68603.999999999, 69118.30881691119, 69729.65135174291, 7488.0, 7548.094228692592, 7672.73145439907, 7835.255650713173, 7878.054633444023, 37386.0, 48663.0, 48945.75527122342, 49005.75497122492, 49072.0, 53623.46376536185, 62691.43271418251, 65560.0, 70755.0, 71577.64211178912, 10781.784364312827, 11010.614628487965, 11232.719182020515, 11234.662960111209, 11391.772164556496, 11831.250530902273, 11970.461329240032, 12002.579909703118, 12268.570600028956, 12654.050946179257, 10921.235513513977, 11100.777984440427, 11326.546938122712, 11375.829362559403, 11745.236559623598, 11139.944300278446, 11460.656180314603, 11461.828072578752, 11481.82777258325, 12307.461567304086, 11001.61494347726, 11207.551697931991, 11227.607033753779, 11433.771324573629, 11460.541578336773, 9332.39339442934, 9685.17675997548, 9803.11548081918, 9836.163926066365, 9913.801723965624, 8493.745187644381, 9535.141837234682, 9589.376690515093, 9595.0, 9612.951935240279], "value": 6887.797352193563, "unit": "score"}], "name": "dromaeo_css", "value": 7471.523667642527, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 119.0, 112.0, 113.0, 112.0, 114.0, 114.0, 114.0, 135.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 156.0, 155.0, 115.0, 142.0, 141.0, 118.0, 169.0, 118.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 188.0, 187.0, 187.0, 188.0, 184.0, 186.0, 187.0, 182.0, 183.0], "value": 185.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 98.0, 107.0, 190.0, 56.0, 54.0, 56.0, 63.0, 132.0, 55.0], "value": 88.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 143.0, 76.0, 80.0, 80.0, 127.0, 80.0, 106.0, 169.0], "value": 105.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 83.0, 87.0, 83.0, 87.0, 85.0, 90.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 97.0, 93.0, 92.0, 92.0, 100.0, 91.0, 92.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 85.0, 85.0, 85.0, 83.0, 85.0, 99.0, 133.0], "value": 91.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 65.0, 63.0, 63.0, 63.0, 65.0, 82.0, 58.0, 58.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 67.0, 81.0, 76.0, 72.0, 70.0, 70.0, 71.0, 71.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 81.0, 80.0, 80.0, 81.0, 80.0, 82.0, 84.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 147.0, 147.0, 129.0, 127.0, 125.0, 130.0, 129.0, 152.0, 134.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 215.0, 187.0, 163.0, 170.0, 169.0, 167.0, 155.0, 165.0, 164.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 69.0, 68.0, 66.0, 68.0, 66.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1500.2, "alertThreshold": 2.0}]} 06:15:07 INFO - Return code: 0 06:15:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:15:07 ERROR - # TBPL SUCCESS # 06:15:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:15:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:15:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:15:07 INFO - 2016-05-09 06:15:07.301 screenresolution[2252:22092] starting screenresolution argv=screenresolution get 06:15:07 INFO - 2016-05-09 06:15:07.304 screenresolution[2252:22092] Display 0: 1600x1200x32@60 06:15:07 INFO - 2016-05-09 06:15:07.310 screenresolution[2253:22095] starting screenresolution argv=screenresolution list 06:15:07 INFO - Available Modes on Display 0 06:15:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:15:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:15:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:15:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:15:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:15:07 INFO - Intel Iris: 06:15:07 INFO - Chipset Model: Intel Iris 06:15:07 INFO - Type: GPU 06:15:07 INFO - Bus: Built-In 06:15:07 INFO - VRAM (Dynamic, Max): 1536 MB 06:15:07 INFO - Vendor: Intel (0x8086) 06:15:07 INFO - Device ID: 0x0a2e 06:15:07 INFO - Revision ID: 0x0009 06:15:07 INFO - Displays: 06:15:07 INFO - Display: 06:15:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:15:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:15:07 INFO - Display Serial Number: 1600x1200 60 06:15:07 INFO - Main Display: Yes 06:15:07 INFO - Mirror: Off 06:15:07 INFO - Online: Yes 06:15:07 INFO - Rotation: Supported 06:15:07 INFO - Return code: 0 06:15:07 INFO - Running post-action listener: _resource_record_post_action 06:15:07 INFO - Running post-run listener: _resource_record_post_run 06:15:08 INFO - Total resource usage - Wall time: 1206s; CPU: 52.0%; Read bytes: 815104; Write bytes: 652411392; Read time: 8; Write time: 1868 06:15:08 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 348680704; Write bytes: 346633728; Read time: 26483; Write time: 698 06:15:08 INFO - run-tests - Wall time: 1176s; CPU: 52.0%; Read bytes: 815104; Write bytes: 294988800; Read time: 8; Write time: 1134 06:15:08 INFO - Running post-run listener: _upload_blobber_files 06:15:08 INFO - Blob upload gear active. 06:15:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:15:08 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 06:15:08 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:15:08 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:15:09 INFO - (blobuploader) - INFO - Open directory for files ... 06:15:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:15:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:15:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:09 INFO - (blobuploader) - INFO - Done attempting. 06:15:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:15:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:15:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:10 INFO - (blobuploader) - INFO - Done attempting. 06:15:10 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:10 INFO - Return code: 0 06:15:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c611ac9e716b5eaa895b3753e974d80948f53c85df0112e5e59c0510723cf5738a471b1e940bddd10581dbf1f04b892baf8d2c401d76e9351630c016baac212a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76822e63a63b4bb00d9a64b48b7a7be838fd979d8c6076ad6f8a0b264653b7a8bc134239e8d90db742461b25400c47aa5f8302145bc511eacd76939f6d13a646"} 06:15:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:10 INFO - Contents: 06:15:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c611ac9e716b5eaa895b3753e974d80948f53c85df0112e5e59c0510723cf5738a471b1e940bddd10581dbf1f04b892baf8d2c401d76e9351630c016baac212a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76822e63a63b4bb00d9a64b48b7a7be838fd979d8c6076ad6f8a0b264653b7a8bc134239e8d90db742461b25400c47aa5f8302145bc511eacd76939f6d13a646"} 06:15:10 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:10 INFO - Copying logs to upload dir... 06:15:10 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.252381 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-05-09 06:15:10.729947) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:15:10.734987) ========= 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.7Pa8TT68Df/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.zdfCgPxonA/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c611ac9e716b5eaa895b3753e974d80948f53c85df0112e5e59c0510723cf5738a471b1e940bddd10581dbf1f04b892baf8d2c401d76e9351630c016baac212a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76822e63a63b4bb00d9a64b48b7a7be838fd979d8c6076ad6f8a0b264653b7a8bc134239e8d90db742461b25400c47aa5f8302145bc511eacd76939f6d13a646"} build_url:https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c611ac9e716b5eaa895b3753e974d80948f53c85df0112e5e59c0510723cf5738a471b1e940bddd10581dbf1f04b892baf8d2c401d76e9351630c016baac212a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76822e63a63b4bb00d9a64b48b7a7be838fd979d8c6076ad6f8a0b264653b7a8bc134239e8d90db742461b25400c47aa5f8302145bc511eacd76939f6d13a646"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:15:10.772647) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:15:10.772968) ========= 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.7Pa8TT68Df/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.zdfCgPxonA/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005329 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:15:10.821566) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:15:10.821866) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:15:10.822160) ========= ========= Total master_lag: 0.19 =========