builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0175 starttime: 1460635907.75 results: success (0) buildid: 20160414034258 builduid: 9072a776d8a1450aa476cd35d91f1938 revision: 589bd8060a90ac2022b7f6dee222cbc4bfc34aa7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 05:11:47.746079) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 05:11:47.746572) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 05:11:47.746907) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 05:11:47.788686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:11:47.789098) ========= 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.dj60VucSxa/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.yiZMIx5GwJ/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-14 05:11:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 44.0M=0s 2016-04-14 05:11:47 (44.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174184 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:11:48.058560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:11:48.058954) ========= 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.dj60VucSxa/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.yiZMIx5GwJ/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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.026731 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:11:48.102819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-14 05:11:48.103586) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 589bd8060a90ac2022b7f6dee222cbc4bfc34aa7 --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 589bd8060a90ac2022b7f6dee222cbc4bfc34aa7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dj60VucSxa/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.yiZMIx5GwJ/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-14 05:11:48,185 truncating revision to first 12 chars 2016-04-14 05:11:48,185 Setting DEBUG logging. 2016-04-14 05:11:48,186 attempt 1/10 2016-04-14 05:11:48,186 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/589bd8060a90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 05:11:50,129 unpacking tar archive at: mozilla-aurora-589bd8060a90/testing/mozharness/ program finished with exit code 0 elapsedTime=2.201783 ========= master_lag: 2.73 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-14 05:11:53.034245) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 05:11:53.034564) ========= script_repo_revision: 589bd8060a90ac2022b7f6dee222cbc4bfc34aa7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 05:11:53.034958) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 05:11:53.038131) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 05:11:53.149939) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-14 05:11:53.150335) ========= /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.dj60VucSxa/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.yiZMIx5GwJ/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:11:53 INFO - MultiFileLogger online at 20160414 05:11:53 in /builds/slave/test 05:11:53 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:11:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:11:53 INFO - {'append_to_log': False, 05:11:53 INFO - 'base_work_dir': '/builds/slave/test', 05:11:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:11:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:11:53 INFO - 'branch': 'Mozilla-Aurora', 05:11:53 INFO - 'buildbot_json_path': 'buildprops.json', 05:11:53 INFO - 'config_files': ('talos/mac_config.py',), 05:11:53 INFO - 'default_actions': ('clobber', 05:11:53 INFO - 'read-buildbot-config', 05:11:53 INFO - 'download-and-extract', 05:11:53 INFO - 'populate-webroot', 05:11:53 INFO - 'create-virtualenv', 05:11:53 INFO - 'install', 05:11:53 INFO - 'run-tests'), 05:11:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:11:53 INFO - 'download_minidump_stackwalk': True, 05:11:53 INFO - 'download_symbols': 'ondemand', 05:11:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:11:53 INFO - 'tooltool.py': '/tools/tooltool.py', 05:11:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:11:53 INFO - '/tools/misc-python/virtualenv.py')}, 05:11:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:11:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:11:53 INFO - 'installer_path': 'installer.exe', 05:11:53 INFO - 'log_level': 'info', 05:11:53 INFO - 'log_name': 'talos', 05:11:53 INFO - 'log_to_console': True, 05:11:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:11:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:11:53 INFO - 'opt_config_files': (), 05:11:53 INFO - 'pip_index': False, 05:11:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:11:53 INFO - 'cmd': ('bash', 05:11:53 INFO - '-c', 05:11:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:11:53 INFO - 'enabled': True, 05:11:53 INFO - 'halt_on_failure': False, 05:11:53 INFO - 'name': 'check_screen_resolution'},), 05:11:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:11:53 INFO - 'cmd': ('bash', 05:11:53 INFO - '-c', 05:11:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:11:53 INFO - 'enabled': True, 05:11:53 INFO - 'halt_on_failure': False, 05:11:53 INFO - 'name': 'check_screen_resolution'},), 05:11:53 INFO - 'run_cmd_checks_enabled': True, 05:11:53 INFO - 'sps_profile': False, 05:11:53 INFO - 'sps_profile_interval': 0, 05:11:53 INFO - 'suite': 'dromaeojs', 05:11:53 INFO - 'system_bits': '32', 05:11:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:11:53 INFO - 'title': 't-yosemite-r7-0175', 05:11:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:11:53 INFO - 'use_talos_json': True, 05:11:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:11:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:11:53 INFO - 'work_dir': 'build'} 05:11:53 INFO - ##### 05:11:53 INFO - ##### Running clobber step. 05:11:53 INFO - ##### 05:11:53 INFO - Running pre-action listener: _resource_record_pre_action 05:11:53 INFO - Running main action method: clobber 05:11:53 INFO - rmtree: /builds/slave/test/build 05:11:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:11:54 INFO - Running post-action listener: _resource_record_post_action 05:11:54 INFO - ##### 05:11:54 INFO - ##### Running read-buildbot-config step. 05:11:54 INFO - ##### 05:11:54 INFO - Running pre-action listener: _resource_record_pre_action 05:11:54 INFO - Running main action method: read_buildbot_config 05:11:54 INFO - Using buildbot properties: 05:11:54 INFO - { 05:11:54 INFO - "project": "", 05:11:54 INFO - "product": "firefox", 05:11:54 INFO - "script_repo_revision": "production", 05:11:54 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:11:54 INFO - "repository": "", 05:11:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:11:54 INFO - "buildid": "20160414034258", 05:11:54 INFO - "pgo_build": "False", 05:11:54 INFO - "basedir": "/builds/slave/test", 05:11:54 INFO - "buildnumber": 178, 05:11:54 INFO - "slavename": "t-yosemite-r7-0175", 05:11:54 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:11:54 INFO - "platform": "yosemite_r7", 05:11:54 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:11:54 INFO - "branch": "mozilla-aurora", 05:11:54 INFO - "repo_path": "releases/mozilla-aurora", 05:11:54 INFO - "revision": "589bd8060a90ac2022b7f6dee222cbc4bfc34aa7", 05:11:54 INFO - "stage_platform": "macosx64", 05:11:54 INFO - "builduid": "9072a776d8a1450aa476cd35d91f1938", 05:11:54 INFO - "slavebuilddir": "test" 05:11:54 INFO - } 05:11:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 05:11:54 INFO - Running post-action listener: _resource_record_post_action 05:11:54 INFO - ##### 05:11:54 INFO - ##### Running download-and-extract step. 05:11:54 INFO - ##### 05:11:54 INFO - Running pre-action listener: _resource_record_pre_action 05:11:54 INFO - Running main action method: download_and_extract 05:11:54 INFO - mkdir: /builds/slave/test/build/tests 05:11:54 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:11:54 INFO - https://queue.taskcluster.net/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:11:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 05:11:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 05:11:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 05:11:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 05:11:55 INFO - Downloaded 1277 bytes. 05:11:55 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 05:11:55 INFO - Using the following test package requirements: 05:11:55 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:11:55 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:11:55 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 05:11:55 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:11:55 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 05:11:55 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:11:55 INFO - u'jsshell-mac.zip'], 05:11:55 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:11:55 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 05:11:55 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:11:55 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:11:55 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 05:11:55 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:11:55 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 05:11:55 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:11:55 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 05:11:55 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:11:55 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:11:55 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 05:11:55 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:11: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:11:55 INFO - https://queue.taskcluster.net/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:11:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:11:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:11:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:11:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:11:57 INFO - Downloaded 17910976 bytes. 05:11:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:11:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:12:00 INFO - Return code: 0 05:12:00 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:00 INFO - https://queue.taskcluster.net/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:12:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:12:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:12:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:12:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:12:01 INFO - Downloaded 17910976 bytes. 05:12:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:12:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:12:04 INFO - Return code: 0 05:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:04 INFO - https://queue.taskcluster.net/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:12:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 05:12:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 05:12:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 05:12:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:12:06 INFO - Downloaded 10845168 bytes. 05:12:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:12:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:12:06 INFO - Return code: 0 05:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:06 INFO - https://queue.taskcluster.net/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 05:12:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 05:12:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 05:12:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 05:12:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 05:12:11 INFO - Downloaded 115197343 bytes. 05:12:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 05:12:11 INFO - mkdir: /builds/slave/test/properties 05:12:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:12:11 INFO - Writing to file /builds/slave/test/properties/build_url 05:12:11 INFO - Contents: 05:12:11 INFO - build_url:https://queue.taskcluster.net/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 05:12:12 INFO - Running post-action listener: _resource_record_post_action 05:12:12 INFO - Running post-action listener: set_extra_try_arguments 05:12:12 INFO - ##### 05:12:12 INFO - ##### Running populate-webroot step. 05:12:12 INFO - ##### 05:12:12 INFO - Running pre-action listener: _resource_record_pre_action 05:12:12 INFO - Running main action method: populate_webroot 05:12:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:12:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:12:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:12:12 INFO - '--tppagecycles', 05:12:12 INFO - '7'], 05:12:12 INFO - 'tests': ['tsvgm']}}, 05:12:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:12:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:12:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:12:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:12:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:12:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:12:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'tests': ['damp', 'tps']}, 05:12:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['damp', 'tps']}, 05:12:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:12:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:12:12 INFO - 'other': {'tests': ['a11yr', 05:12:12 INFO - 'ts_paint', 05:12:12 INFO - 'tpaint', 05:12:12 INFO - 'sessionrestore', 05:12:12 INFO - 'sessionrestore_no_auto_restore', 05:12:12 INFO - 'tabpaint']}, 05:12:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['a11yr', 05:12:12 INFO - 'ts_paint', 05:12:12 INFO - 'tpaint', 05:12:12 INFO - 'sessionrestore', 05:12:12 INFO - 'sessionrestore_no_auto_restore', 05:12:12 INFO - 'tabpaint']}, 05:12:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['a11yr', 05:12:12 INFO - 'ts_paint', 05:12:12 INFO - 'tpaint', 05:12:12 INFO - 'sessionrestore', 05:12:12 INFO - 'sessionrestore_no_auto_restore', 05:12:12 INFO - 'tabpaint']}, 05:12:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['a11yr', 05:12:12 INFO - 'ts_paint', 05:12:12 INFO - 'tpaint', 05:12:12 INFO - 'sessionrestore', 05:12:12 INFO - 'sessionrestore_no_auto_restore', 05:12:12 INFO - 'tabpaint']}, 05:12:12 INFO - 'other_l64': {'tests': ['a11yr', 05:12:12 INFO - 'ts_paint', 05:12:12 INFO - 'tpaint', 05:12:12 INFO - 'sessionrestore', 05:12:12 INFO - 'sessionrestore_no_auto_restore', 05:12:12 INFO - 'tabpaint']}, 05:12:12 INFO - 'other_nol64': {'tests': ['a11yr', 05:12:12 INFO - 'ts_paint', 05:12:12 INFO - 'tpaint', 05:12:12 INFO - 'sessionrestore', 05:12:12 INFO - 'sessionrestore_no_auto_restore', 05:12:12 INFO - 'tabpaint']}, 05:12:12 INFO - 'svgr': {'tests': ['tsvgx', 05:12:12 INFO - 'tsvgr_opacity', 05:12:12 INFO - 'tart', 05:12:12 INFO - 'tscrollx', 05:12:12 INFO - 'cart']}, 05:12:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['tsvgx', 05:12:12 INFO - 'tsvgr_opacity', 05:12:12 INFO - 'tart', 05:12:12 INFO - 'tscrollx', 05:12:12 INFO - 'cart']}, 05:12:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'tests': ['tp5o']}, 05:12:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['tp5o']}, 05:12:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'talos_options': ['--xperf_path', 05:12:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:12:12 INFO - 'tests': ['tp5n']}, 05:12:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'talos_options': ['--e10s', 05:12:12 INFO - '--xperf_path', 05:12:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:12:12 INFO - 'tests': ['tp5n']}}, 05:12:12 INFO - 'talos.zip': {'path': '', 05:12:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:12:12 INFO - Running post-action listener: _resource_record_post_action 05:12:12 INFO - ##### 05:12:12 INFO - ##### Running create-virtualenv step. 05:12:12 INFO - ##### 05:12:12 INFO - Running pre-action listener: _resource_record_pre_action 05:12:12 INFO - Running main action method: create_virtualenv 05:12:12 INFO - Creating virtualenv /builds/slave/test/build/venv 05:12:12 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:12:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:12:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:12:12 INFO - Using real prefix '/tools/python27' 05:12:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:12:13 INFO - Installing distribute.............................................................................................................................................................................................done. 05:12:16 INFO - Installing pip.................done. 05:12:16 INFO - Return code: 0 05:12:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:16 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 0x10967ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefd0c5c510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109522d30>, '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 0x109386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109519b20>, '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.dj60VucSxa/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.yiZMIx5GwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:12:16 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:12:16 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:12:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dj60VucSxa/Render', 05:12:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:16 INFO - 'HOME': '/Users/cltbld', 05:12:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:16 INFO - 'LOGNAME': 'cltbld', 05:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:16 INFO - 'MOZ_NO_REMOTE': '1', 05:12:16 INFO - 'NO_EM_RESTART': '1', 05:12:16 INFO - 'PAGER': '/bin/cat', 05:12:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:16 INFO - 'PWD': '/builds/slave/test', 05:12:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:16 INFO - 'SHELL': '/bin/bash', 05:12:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiZMIx5GwJ/Listeners', 05:12:16 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:12:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:16 INFO - 'USER': 'cltbld', 05:12:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:16 INFO - 'XPC_FLAGS': '0x0', 05:12:16 INFO - 'XPC_SERVICE_NAME': '0', 05:12:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:17 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:12:17 INFO - Cleaning up... 05:12:17 INFO - Return code: 0 05:12:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:17 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 0x10967ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefd0c5c510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109522d30>, '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 0x109386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109519b20>, '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.dj60VucSxa/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.yiZMIx5GwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:12:17 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:12:17 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:12:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dj60VucSxa/Render', 05:12:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:17 INFO - 'HOME': '/Users/cltbld', 05:12:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:17 INFO - 'LOGNAME': 'cltbld', 05:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:17 INFO - 'MOZ_NO_REMOTE': '1', 05:12:17 INFO - 'NO_EM_RESTART': '1', 05:12:17 INFO - 'PAGER': '/bin/cat', 05:12:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:17 INFO - 'PWD': '/builds/slave/test', 05:12:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:17 INFO - 'SHELL': '/bin/bash', 05:12:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiZMIx5GwJ/Listeners', 05:12:17 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:12:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:17 INFO - 'USER': 'cltbld', 05:12:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:17 INFO - 'XPC_FLAGS': '0x0', 05:12:17 INFO - 'XPC_SERVICE_NAME': '0', 05:12:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:17 INFO - Downloading/unpacking psutil>=0.7.1 05:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:12:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:20 INFO - Installing collected packages: psutil 05:12:20 INFO - Running setup.py install for psutil 05:12:20 INFO - building 'psutil._psutil_osx' extension 05:12:20 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:12:21 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:12:21 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:12:21 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:12:21 INFO - building 'psutil._psutil_posix' extension 05:12:21 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:12:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:12:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:12:21 INFO - ^ 05:12:21 INFO - 1 warning generated. 05:12:21 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:12:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:21 INFO - Successfully installed psutil 05:12:21 INFO - Cleaning up... 05:12:21 INFO - Return code: 0 05:12:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10967ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefd0c5c510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109522d30>, '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 0x109386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109519b20>, '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.dj60VucSxa/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.yiZMIx5GwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:12:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:12:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dj60VucSxa/Render', 05:12:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:21 INFO - 'HOME': '/Users/cltbld', 05:12:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:21 INFO - 'LOGNAME': 'cltbld', 05:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:21 INFO - 'MOZ_NO_REMOTE': '1', 05:12:21 INFO - 'NO_EM_RESTART': '1', 05:12:21 INFO - 'PAGER': '/bin/cat', 05:12:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:21 INFO - 'PWD': '/builds/slave/test', 05:12:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:21 INFO - 'SHELL': '/bin/bash', 05:12:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiZMIx5GwJ/Listeners', 05:12:21 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:12:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:21 INFO - 'USER': 'cltbld', 05:12:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:21 INFO - 'XPC_FLAGS': '0x0', 05:12:21 INFO - 'XPC_SERVICE_NAME': '0', 05:12:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:12:21 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:12:21 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:12:21 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:12:21 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:12:21 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:12:21 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:12:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:12:24 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:12:24 INFO - Installing collected packages: mozsystemmonitor 05:12:24 INFO - Running setup.py install for mozsystemmonitor 05:12:24 INFO - Successfully installed mozsystemmonitor 05:12:24 INFO - Cleaning up... 05:12:24 INFO - Return code: 0 05:12:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:24 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 0x10967ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefd0c5c510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109522d30>, '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 0x109386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109519b20>, '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.dj60VucSxa/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.yiZMIx5GwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:12:24 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:12:24 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:12:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dj60VucSxa/Render', 05:12:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:24 INFO - 'HOME': '/Users/cltbld', 05:12:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:24 INFO - 'LOGNAME': 'cltbld', 05:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:24 INFO - 'MOZ_NO_REMOTE': '1', 05:12:24 INFO - 'NO_EM_RESTART': '1', 05:12:24 INFO - 'PAGER': '/bin/cat', 05:12:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:24 INFO - 'PWD': '/builds/slave/test', 05:12:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:24 INFO - 'SHELL': '/bin/bash', 05:12:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiZMIx5GwJ/Listeners', 05:12:24 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:12:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:24 INFO - 'USER': 'cltbld', 05:12:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:24 INFO - 'XPC_FLAGS': '0x0', 05:12:24 INFO - 'XPC_SERVICE_NAME': '0', 05:12:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:24 INFO - Downloading/unpacking blobuploader==1.2.4 05:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:12:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:12:27 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:12:27 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:12:27 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:12:27 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:12:27 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:12:27 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:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:12:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:28 INFO - Downloading docopt-0.6.1.tar.gz 05:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:12:28 INFO - Installing collected packages: blobuploader, requests, docopt 05:12:28 INFO - Running setup.py install for blobuploader 05:12:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:12:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:12:28 INFO - Running setup.py install for requests 05:12:29 INFO - Running setup.py install for docopt 05:12:29 INFO - Successfully installed blobuploader requests docopt 05:12:29 INFO - Cleaning up... 05:12:29 INFO - Return code: 0 05:12:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:29 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 0x10967ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefd0c5c510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109522d30>, '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 0x109386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109519b20>, '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.dj60VucSxa/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.yiZMIx5GwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:12:29 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:12:29 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:12:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dj60VucSxa/Render', 05:12:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:29 INFO - 'HOME': '/Users/cltbld', 05:12:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:29 INFO - 'LOGNAME': 'cltbld', 05:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:29 INFO - 'MOZ_NO_REMOTE': '1', 05:12:29 INFO - 'NO_EM_RESTART': '1', 05:12:29 INFO - 'PAGER': '/bin/cat', 05:12:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:29 INFO - 'PWD': '/builds/slave/test', 05:12:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:29 INFO - 'SHELL': '/bin/bash', 05:12:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiZMIx5GwJ/Listeners', 05:12:29 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:12:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:29 INFO - 'USER': 'cltbld', 05:12:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:29 INFO - 'XPC_FLAGS': '0x0', 05:12:29 INFO - 'XPC_SERVICE_NAME': '0', 05:12:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:29 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-VWNlJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:29 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-JafK1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:29 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-hWjdOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:30 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-rTQR7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:30 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-s0j1tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:30 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-y5USbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:30 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-8Rqx9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:30 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-bKhn07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:30 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-st6WON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:30 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-27b0Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:30 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-vWmnu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:30 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-8IbnVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:31 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-rQRKfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:31 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-M_CKiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:31 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-X2higX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:31 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-ah0xTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:31 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-JTPtd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:12:31 INFO - Running setup.py install for manifestparser 05:12:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:12:31 INFO - Running setup.py install for mozcrash 05:12:31 INFO - Running setup.py install for mozdebug 05:12:31 INFO - Running setup.py install for mozdevice 05:12:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:12:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:12:32 INFO - Running setup.py install for mozfile 05:12:32 INFO - Running setup.py install for mozhttpd 05:12:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:12:32 INFO - Running setup.py install for mozinfo 05:12:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:12:32 INFO - Running setup.py install for mozInstall 05:12:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:12:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:12:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:12:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:12:32 INFO - Running setup.py install for mozleak 05:12:32 INFO - Running setup.py install for mozlog 05:12:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:12:33 INFO - Running setup.py install for moznetwork 05:12:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:12:33 INFO - Running setup.py install for mozprocess 05:12:33 INFO - Running setup.py install for mozprofile 05:12:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:12:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:12:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:12:33 INFO - Running setup.py install for mozrunner 05:12:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:12:33 INFO - Running setup.py install for mozscreenshot 05:12:33 INFO - Running setup.py install for moztest 05:12:33 INFO - Running setup.py install for mozversion 05:12:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:12:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:12:34 INFO - Cleaning up... 05:12:34 INFO - Return code: 0 05:12:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12: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:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12: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:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:34 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 0x10967ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefd0c5c510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109522d30>, '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 0x109386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109519b20>, '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.dj60VucSxa/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.yiZMIx5GwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:12:34 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:12:34 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:12:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dj60VucSxa/Render', 05:12:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:34 INFO - 'HOME': '/Users/cltbld', 05:12:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:34 INFO - 'LOGNAME': 'cltbld', 05:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:34 INFO - 'MOZ_NO_REMOTE': '1', 05:12:34 INFO - 'NO_EM_RESTART': '1', 05:12:34 INFO - 'PAGER': '/bin/cat', 05:12:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:34 INFO - 'PWD': '/builds/slave/test', 05:12:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:34 INFO - 'SHELL': '/bin/bash', 05:12:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiZMIx5GwJ/Listeners', 05:12:34 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:12:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:34 INFO - 'USER': 'cltbld', 05:12:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:34 INFO - 'XPC_FLAGS': '0x0', 05:12:34 INFO - 'XPC_SERVICE_NAME': '0', 05:12:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:34 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-mO3t77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:34 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:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:34 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-_B2uce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:34 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:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:34 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-obeUFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:34 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:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:34 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-NXSuQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:34 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:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:34 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-S4c1fH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:34 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:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:34 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-SGyRrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:35 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:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:35 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-GPtujn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:35 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:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:35 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-0g9ZNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:35 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:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:35 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-nKKOrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:35 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:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:35 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-nASEgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:35 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:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:35 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-rT9GBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:35 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:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:35 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-uGsFmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:35 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:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:35 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-x0JxTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:35 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:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:35 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-u4b51p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:35 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:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:35 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-yfU3Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:35 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:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:36 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-L_0qp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:36 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:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:36 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-TWhDBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:36 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:12:36 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:12:36 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:12:36 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:12:36 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:12:36 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:12:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:38 INFO - Downloading blessings-1.6.tar.gz 05:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:12:38 INFO - Installing collected packages: blessings 05:12:38 INFO - Running setup.py install for blessings 05:12:38 INFO - Successfully installed blessings 05:12:38 INFO - Cleaning up... 05:12:39 INFO - Return code: 0 05:12:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:12:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:39 INFO - Reading from file tmpfile_stdout 05:12:39 INFO - Current package versions: 05:12:39 INFO - blessings == 1.6 05:12:39 INFO - blobuploader == 1.2.4 05:12:39 INFO - docopt == 0.6.1 05:12:39 INFO - manifestparser == 1.1 05:12:39 INFO - mozInstall == 1.12 05:12:39 INFO - mozcrash == 0.17 05:12:39 INFO - mozdebug == 0.1 05:12:39 INFO - mozdevice == 0.48 05:12:39 INFO - mozfile == 1.2 05:12:39 INFO - mozhttpd == 0.7 05:12:39 INFO - mozinfo == 0.9 05:12:39 INFO - mozleak == 0.1 05:12:39 INFO - mozlog == 3.1 05:12:39 INFO - moznetwork == 0.27 05:12:39 INFO - mozprocess == 0.22 05:12:39 INFO - mozprofile == 0.28 05:12:39 INFO - mozrunner == 6.11 05:12:39 INFO - mozscreenshot == 0.1 05:12:39 INFO - mozsystemmonitor == 0.0 05:12:39 INFO - moztest == 0.7 05:12:39 INFO - mozversion == 1.4 05:12:39 INFO - psutil == 3.1.1 05:12:39 INFO - requests == 1.2.3 05:12:39 INFO - wsgiref == 0.1.2 05:12:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:39 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 0x10967ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefd0c5c510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109522d30>, '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 0x109386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109519b20>, '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.dj60VucSxa/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.yiZMIx5GwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:12:39 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:12:39 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:12:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dj60VucSxa/Render', 05:12:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:39 INFO - 'HOME': '/Users/cltbld', 05:12:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:39 INFO - 'LOGNAME': 'cltbld', 05:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:39 INFO - 'MOZ_NO_REMOTE': '1', 05:12:39 INFO - 'NO_EM_RESTART': '1', 05:12:39 INFO - 'PAGER': '/bin/cat', 05:12:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:39 INFO - 'PWD': '/builds/slave/test', 05:12:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:39 INFO - 'SHELL': '/bin/bash', 05:12:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiZMIx5GwJ/Listeners', 05:12:39 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:12:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:39 INFO - 'USER': 'cltbld', 05:12:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:39 INFO - 'XPC_FLAGS': '0x0', 05:12:39 INFO - 'XPC_SERVICE_NAME': '0', 05:12:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:39 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:12:39 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:12:39 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:12:39 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:12:39 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:12:39 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:12:39 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:12:39 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:12:39 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:12:39 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:12:39 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:12:39 INFO - Cleaning up... 05:12:39 INFO - Return code: 0 05:12:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:39 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 0x10967ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefd0c5c510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109522d30>, '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 0x109386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109519b20>, '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.dj60VucSxa/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.yiZMIx5GwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:12:39 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:12:39 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:12:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dj60VucSxa/Render', 05:12:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:39 INFO - 'HOME': '/Users/cltbld', 05:12:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:39 INFO - 'LOGNAME': 'cltbld', 05:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:39 INFO - 'MOZ_NO_REMOTE': '1', 05:12:39 INFO - 'NO_EM_RESTART': '1', 05:12:39 INFO - 'PAGER': '/bin/cat', 05:12:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:39 INFO - 'PWD': '/builds/slave/test', 05:12:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:39 INFO - 'SHELL': '/bin/bash', 05:12:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiZMIx5GwJ/Listeners', 05:12:39 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:12:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:39 INFO - 'USER': 'cltbld', 05:12:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:39 INFO - 'XPC_FLAGS': '0x0', 05:12:39 INFO - 'XPC_SERVICE_NAME': '0', 05:12:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:39 INFO - Downloading/unpacking jsonschema 05:12:39 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:12:39 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:12:39 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:12:39 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:12:39 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:12:39 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:12:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:12:42 INFO - Downloading/unpacking functools32 (from jsonschema) 05:12:42 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:12:42 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:12:42 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:12:42 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:12:42 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:12:42 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:12:42 INFO - Downloading functools32-3.2.3-2.tar.gz 05:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:12:42 INFO - warning: no files found matching '*.txt' 05:12:42 INFO - no previously-included directories found matching 'build' 05:12:42 INFO - no previously-included directories found matching 'dist' 05:12:42 INFO - no previously-included directories found matching '.git*' 05:12:42 INFO - Installing collected packages: jsonschema, functools32 05:12:42 INFO - Running setup.py install for functools32 05:12:42 INFO - warning: no files found matching '*.txt' 05:12:42 INFO - no previously-included directories found matching 'build' 05:12:42 INFO - no previously-included directories found matching 'dist' 05:12:42 INFO - no previously-included directories found matching '.git*' 05:12:42 INFO - Successfully installed jsonschema functools32 05:12:42 INFO - Cleaning up... 05:12:42 INFO - Return code: 0 05:12:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:12: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:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:43 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 0x10967ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefd0c5c510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109522d30>, '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 0x109386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109519b20>, '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.dj60VucSxa/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.yiZMIx5GwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:12:43 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:12:43 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:12:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dj60VucSxa/Render', 05:12:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:43 INFO - 'HOME': '/Users/cltbld', 05:12:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:43 INFO - 'LOGNAME': 'cltbld', 05:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:43 INFO - 'MOZ_NO_REMOTE': '1', 05:12:43 INFO - 'NO_EM_RESTART': '1', 05:12:43 INFO - 'PAGER': '/bin/cat', 05:12:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:43 INFO - 'PWD': '/builds/slave/test', 05:12:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:43 INFO - 'SHELL': '/bin/bash', 05:12:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiZMIx5GwJ/Listeners', 05:12:43 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:12:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:43 INFO - 'USER': 'cltbld', 05:12:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:43 INFO - 'XPC_FLAGS': '0x0', 05:12:43 INFO - 'XPC_SERVICE_NAME': '0', 05:12:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:43 INFO - Downloading/unpacking flake8 05:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:12:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:12:46 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:12:46 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:12:46 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:12:46 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:12:46 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:12:46 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:12:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:12:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:12:46 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:12:46 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:12:46 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:12:46 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:12:46 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:12:46 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:12:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:12:47 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:12:47 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:12:47 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:12:47 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:12:47 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:12:47 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:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:12:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:12:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:12:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:12:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:12:47 INFO - no previously-included directories found matching 'docs/_build' 05:12:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:12:47 INFO - Running setup.py install for pep8 05:12:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:12:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:12:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:12:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:12:47 INFO - no previously-included directories found matching 'docs/_build' 05:12:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:12:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:12:47 INFO - Cleaning up... 05:12:48 INFO - Return code: 0 05:12:48 INFO - Running post-action listener: _resource_record_post_action 05:12:48 INFO - Running post-action listener: _start_resource_monitoring 05:12:48 INFO - Starting resource monitoring. 05:12:48 INFO - ##### 05:12:48 INFO - ##### Running install step. 05:12:48 INFO - ##### 05:12:48 INFO - Running pre-action listener: _resource_record_pre_action 05:12:48 INFO - Running main action method: install 05:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:48 INFO - Reading from file tmpfile_stdout 05:12:48 INFO - Detecting whether we're running mozinstall >=1.0... 05:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:12:48 INFO - Reading from file tmpfile_stdout 05:12:48 INFO - Output received: 05:12:48 INFO - Usage: mozinstall [options] installer 05:12:48 INFO - Options: 05:12:48 INFO - -h, --help show this help message and exit 05:12:48 INFO - -d DEST, --destination=DEST 05:12:48 INFO - Directory to install application into. [default: 05:12:48 INFO - "/builds/slave/test"] 05:12:48 INFO - --app=APP Application being installed. [default: firefox] 05:12:48 INFO - mkdir: /builds/slave/test/build/application 05:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:13:20 INFO - Reading from file tmpfile_stdout 05:13:20 INFO - Output received: 05:13:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:13:20 INFO - Running post-action listener: _resource_record_post_action 05:13:20 INFO - ##### 05:13:20 INFO - ##### Running run-tests step. 05:13:20 INFO - ##### 05:13:20 INFO - Running pre-action listener: _resource_record_pre_action 05:13:20 INFO - Running main action method: run_tests 05:13:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:13:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:13:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:13:20 INFO - 2016-04-14 05:13:20.407 screenresolution[1640:7486] starting screenresolution argv=screenresolution get 05:13:20 INFO - 2016-04-14 05:13:20.409 screenresolution[1640:7486] Display 0: 1600x1200x32@60 05:13:20 INFO - 2016-04-14 05:13:20.415 screenresolution[1641:7489] starting screenresolution argv=screenresolution list 05:13:20 INFO - Available Modes on Display 0 05:13:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:13:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:13:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:13:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:13:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:13:20 INFO - Intel Iris: 05:13:20 INFO - Chipset Model: Intel Iris 05:13:20 INFO - Type: GPU 05:13:20 INFO - Bus: Built-In 05:13:20 INFO - VRAM (Dynamic, Max): 1536 MB 05:13:20 INFO - Vendor: Intel (0x8086) 05:13:20 INFO - Device ID: 0x0a2e 05:13:20 INFO - Revision ID: 0x0009 05:13:20 INFO - Displays: 05:13:20 INFO - Display: 05:13:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:13:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:13:20 INFO - Display Serial Number: 1600x1200 60 05:13:20 INFO - Main Display: Yes 05:13:20 INFO - Mirror: Off 05:13:20 INFO - Online: Yes 05:13:20 INFO - Rotation: Supported 05:13:20 INFO - Return code: 0 05:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:13:20 INFO - Python 2.7.3 05:13:20 INFO - Return code: 0 05:13:20 INFO - grabbing minidump binary from tooltool 05:13: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:13:20 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 0x109522d30>, '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 0x109386db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109519b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:13:20 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:13:20 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:13:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:13:20 INFO - Return code: 0 05:13:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:13:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:13:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:13:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:13:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:13:21 INFO - Return code: 0 05:13:21 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/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0175', '--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:13:21 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/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0175 --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:13:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dj60VucSxa/Render', 05:13:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:21 INFO - 'HOME': '/Users/cltbld', 05:13:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:21 INFO - 'LOGNAME': 'cltbld', 05:13:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:13:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:21 INFO - 'MOZ_NO_REMOTE': '1', 05:13:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:13:21 INFO - 'NO_EM_RESTART': '1', 05:13:21 INFO - 'PAGER': '/bin/cat', 05:13:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:21 INFO - 'PWD': '/builds/slave/test', 05:13:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:13:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:21 INFO - 'SHELL': '/bin/bash', 05:13:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiZMIx5GwJ/Listeners', 05:13:21 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:13:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:21 INFO - 'USER': 'cltbld', 05:13:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:21 INFO - 'XPC_FLAGS': '0x0', 05:13:21 INFO - 'XPC_SERVICE_NAME': '0', 05:13:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:21 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/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0175', '--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:13:22 INFO - mozversion application_buildid: 20160414034258 05:13:22 INFO - mozversion application_changeset: 589bd8060a90ac2022b7f6dee222cbc4bfc34aa7 05:13:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:13:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:13:22 INFO - mozversion application_name: Firefox 05:13:22 INFO - mozversion application_remotingname: firefox-dev 05:13:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:13:22 INFO - mozversion application_vendor: Mozilla 05:13:22 INFO - mozversion application_version: 47.0a2 05:13:22 INFO - mozversion platform_buildid: 20160414034258 05:13:22 INFO - mozversion platform_changeset: 589bd8060a90ac2022b7f6dee222cbc4bfc34aa7 05:13:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:13:22 INFO - mozversion platform_version: 47.0a2 05:13:22 INFO - using testdate: 1460636002 05:13:22 INFO - actual date: 1460636002 05:13:22 INFO - starting webserver on 'localhost:49275' 05:13:22 INFO - SUITE-START | Running 2 tests 05:13:22 INFO - TEST-START | dromaeo_css 05:13:22 INFO - operating with platform_type : mac_ 05:13:22 INFO - Initialising browser for dromaeo_css test... 05:13:22 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpq45yvC/profile http://localhost:49275/getInfo.html) 05:13:24 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 05:13:24 INFO - PROCESS | 1659 | colorDepth:24 05:13:24 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 05:13:24 INFO - PROCESS | 1659 | __metrics 05:13:24 INFO - PROCESS | 1659 | 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:13:24 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:13:25 INFO - TEST-INFO | 1659: exit 0 05:13:25 INFO - Browser initialized. 05:13:25 INFO - Running cycle 1/1 for dromaeo_css test... 05:13:25 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpq45yvC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:37 INFO - PROCESS | 1664 | RSS: Main: 207589376 05:13:37 INFO - PROCESS | 1664 | 05:14:28 INFO - PROCESS | 1664 | 1460636068629 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:16:39 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 05:16:40 INFO - PROCESS | 1664 | RSS: Main: 331374592 05:16:40 INFO - PROCESS | 1664 | 05:19:42 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 05:19:43 INFO - PROCESS | 1664 | RSS: Main: 342556672 05:19:43 INFO - PROCESS | 1664 | 05:22:45 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 05:22:45 INFO - PROCESS | 1664 | RSS: Main: 344940544 05:22:45 INFO - PROCESS | 1664 | 05:25:47 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 05:25:48 INFO - PROCESS | 1664 | RSS: Main: 302919680 05:25:48 INFO - PROCESS | 1664 | 05:28:51 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 05:28:52 INFO - PROCESS | 1664 | RSS: Main: 304582656 05:28:52 INFO - PROCESS | 1664 | 05:31:54 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 05:31:55 INFO - PROCESS | 1664 | RSS: Main: 385728512 05:31:55 INFO - PROCESS | 1664 | 05:31:55 INFO - PROCESS | 1664 | __start_tp_report 05:31:55 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 05:31:55 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 05:31:55 INFO - PROCESS | 1664 | |i|pagename|runs| 05:31:55 INFO - PROCESS | 1664 | |0;dojo.html;3431.8284085795713;3476.374252634525;3491.999999999999;3512.8594856205755;3543.255916257586;5616.101423772197;5637.577181711373;5662.915056274159;5663.801766938158;5664;5623.971880140603;5650.51970582501;5664.150377443386;5674.00704876647;5674.460926212003;5035.672681275723;5083.694978301295;5095.082885080693;5148.819791307305;5160.2517634942915;5221.556167725748;5236.502532259429;5237.73811309433;5240.973795131019;5243.344581927259;5117.13008788505;5155.484451554833;5192.792288308463;5197.454267301936;5200.037992971313;5184.300119483878;5226.8693282667855;5233.895322093536;5241.580673546107;5270.156774916033;4889.5354941280875;5022.246663000543;5035.647504674675;5066.518680725362;5144.794208231666;5570.5822063345;5581.581381396411;5608.186812912146;5609.467100625434;5614.887702245932;6079.817605471843;6220.813375598694;6250.0624906263965;6252.499800015988;6259.186305780219;6189.133521307021;6224.128621992924;6281.152044474029;6323.399277068671;6363;5733.16869053989;5759.798407055733;5765.509931655814;5797.710114494258;5798.855028624318;6262.185915830913;6286.654234017173;6369.26753423353;6386.552941294158;6400.263969643551;6093.847653808691;6106.786262480792;6123.020316749388;6130.877382452326;6136.846578835565;6250.624962502265;6264.874702505925;6269.8746025079245;6272.1219029335925;6277.654728989858;6039.486643635252;6119.746288422706;6139.815805525842;6201.472874805602;6202.379762023762;6133.457080270857;6187;6204.7828326008375;6206.0690896365;6210.844728881814;4858.149823780825;4863.440704318978;4865.0999565079865;4869.977304766039;4879.609631229493;4330.28550289205;4389.648828093745;4404.2512772828695;4406.20688276107;4451.265541185668;5673.461021203062;5709.628874123168;5727.398623144593;5731.083026715705;5739.913901291484;6126.142340072304;6165.84585385369;6166.044263139221;6175.413335733098;6184.969075154685;5704.030314846486;5735.9139612905;5743.2246646703;5773.931822612746;5779.942200578024;4585.747783871919;5345.091334473149;5367.838964831061;5369.731513424391;5394.163904594794;6262.09199666055;6292.433680968735;6359.109724638462;6361.745530178741;6364.49084073273;6245.750169993149;6298.905516417166;6300.401461861115;6301.086342480223;6304.65324407162;6289.339619339903;6312;6325.1144839721555;6345.746170153142;6359.109724638647;5182.24857395683;5921.881562368642;5994.310654274815;6096.993995990611;6121.173641558333;6104.755809767559;6130.47890929276;6255.812325630239;6256.499480041677;6267.2165979252595;6016.969915150396;6036.275646922398;6050.394960503914;6051.848703782264;6068.605540639845;5805.303363596396;5873.823785286449;5963.314218864886;5993.70031498432;6044.972354699799;5862.765489380377;5868.970655146697;5879.470847623735;5885.646861188342;5891.086881533369;5332.440093790096;5927.733252003584;6047.244094488189;6051.697415129138;6056.848578785565;5698.458646428749;5824.621399609012;5879;5883.146943693055;5889.411058894077 05:31:55 INFO - PROCESS | 1664 | |1;ext.html;488.040999436108;591.0454615795489;591.9378465261148;650.1612919334059;657.4937298280324;28719.712802871964;34990.3001939961;37442.43836342457;39592;39814.800925995405;42461.93845153873;43210.351844722354;43254.35118473225;43255;43414;9650.227981761478;9846.45844478557;9875.851862222073;9882.357646752975;9890.456024918627;9668;9843.310968232227;9845.950770246174;9852.605895764162;9853.901460985406;9764.902350976507;9944.6519371822;9951.502424878727;9974.850377244311;10008.199344052495;9854.704358869245;9908.80182396348;9931.304808663324;9953.850692239623;9961.352512086727;9713.56288966991;9861.211103111735;9864.704058878246;9866.901330986742;9879.851802222973;34266;41138;41482.377764333556;41579.168416631495;41613.58386416127;3334.6665333466703;3352.5641666583433;3474.9652503474895;3486.250456151914;3920.4511368408444;26246.86876565624;27257.182284531496;27307.72692273072;27335.726642733516;27587.72412275892;2511.0332521978985;2513.6983561972497;2719.5011765640406;2762.986185069062;2787.2613757354115;412905;414731;416670;418709;419581;64759.67620161869;64976;65093.674531627985;65144.34855651478;65182;66679.33320666828;74813;75875.24124758792;76196.23803762002;76283.85574216391;18094;18153.27386904509;18205.27178912829;18308.816911830978;18332;13865.306734663227;13933.930330348487;13947.790783138262;13960.511382101578;13968.231747253998;19407.417777466697;20358.18567257323;21696;21885.781142188695;21956.011979460964;7550.509216900884;7612.657430415645;7808.843823123506;8877.493390111;9012.233960113334;921.8663293822358;982.4940155819759;1105.3975583307117;1147.6155487911642;1200.0579545057087;29919.85040074786;30077.09768706942;30259.69740302613;30762;30782.846085769426;1111.183280288987;1118.8601424821898;1165.8659254185877;1201.0211677482823;1202.2185579373302;15442.536723898076;15461.768073478906;15508.654027776405;15577.610559736097;15655.217239137997;554006;556304;557565;558631;559006;61557;62220.06669899955;62281.44296392536;62341;62375;1294.838145231846;1434.3473719457622;1535.5163123616026;1587.016050048977;1630.7390817469147;24633.630495542224;29071.273218169714;29152.708472915;29937.700622993492;30060;48886.75556622194;49270;49565.50434495609;49744.75127624483;49787.502124979736;377046;378243;378737;379130;379641;28860.27849303784;30629;34752.826235869674;34946.9515914523;35371.46942795809;42636.360454592585;44139.77930110329;47911.520884790705;49175.329868053064;49834;36956;37959;39781.2043759129;40804.79597601993;41151.176976460905;36353.45469817902;37000.44499332566;37185.62814371822;37453.06367340838;37707.2458550822;36657.816710916275;36717.26565468729;37306.6269337314;37912.43131352977;38039.61960380361;32114.19714507156;32303.51544726878;32929;33030.009099727045;33111.83444082764;21804.56390872142;25527.872360638077;26071.08751193775;26166.86916565405;26284.73715262823 05:31:55 INFO - PROCESS | 1664 | |2;jquery.html;375.47058647307296;378.57788565749183;378.9166383395652;381.7823840410967;386.329717939375;20062.297819576317;20489.692654610193;20911.372658820223;21150.89424552875;21175;20419.693704594443;20730.481737956557;21304.57390852182;21385.679214811753;21635.891820540914;5257.421683614799;5459.235707001023;5467.890642187154;5495.835124946258;5497.642653227547;3991.1419044905338;5791.82624521265;6046.576739628228;6046.7883624073165;6057.151998720161;5955.285365756115;6003.159557661931;6029.788957386492;6049.939500604982;6052.515798736091;5883.499902508292;6029.457348838604;6069.57512974092;6074.3621919698235;6090.360512146227;5408.13469844823;5768.990426675315;5777.075667893159;5787.913181302284;5789.536837053068;13529.391177396943;13698.657533561642;13762.587122386345;13793.310334483236;13797.379117939616;2162.8918554072393;2206.150632006673;2322.547103314854;2411.7588241175918;2633.1837130489416;9797.06927841854;10051.597936082548;10163.4918254087;10292.176625869912;10536.26246162769;1746.5458980665119;1788.4098247578268;1800.7028840241344;1844.3729132095152;1955.4720225539168;90041.09958900392;104301.47849260781;104635.47682261615;106298.46850765774;112197.31704024447;9129.315301352424;10995.120390368751;11408.657740267805;11755.000824929977;11834.704132396586;14591.73828056653;14651.92674036623;14700.852991470163;14716.33776480061;14724.411023558938;8824.161704638049;8835.55822208887;8878.156575125353;9001.324900632479;9096.090390960851;7548;8248.8350232995;8435.746927592181;9222.86165707515;9339.486328251876;3757.511523501982;4557.817687292471;4627.305904114342;4663.580277775017;4685.508021657745;1809.7375880497254;1826.2488610703936;1859.981400186008;1920.9231630734614;1969.5962327722782;924.856647219682;931.6273490603812;1016.5781200801732;1032.396048311731;1037.64719995202;20498.59002819965;20805.583888322148;21465.57068858614;21487;21516.354509364744;984.8276551603441;1016.5577973581516;1028.8713910761155;1071.314358810362;1087.9564817407215;11217.60738374153;11588.94205528967;11613;11615.535378584931;11624.88375116238;667098;668379;670740;685470;689861;128202;130338;134822.56242063158;135530;137295;1032.5972870580479;1041.8280983637615;1046.9371837689764;1060.2790102730216;1063.1919740996898;18327.54181145482;18795.530111747317;18933.526661833563;19085.427437176906;19611.215551378355;40269.39595906005;51691.74154129356;53056.46943530515;53556.73221633867;53736.73131634317;69262;70503;70714.29285707077;71159;75504.24495754972;7010.579365238102;8198;8266.710665126691;8380.161983801814;8418.98972123349;13268.93365533166;13606.795898061338;13612;13836.792448113085;13868.167909925436;11756.529738810352;11766.176367654181;11846.229995050295;11976.041916646473;12038.939805300917;11267.211295209258;11295.830562541403;11468.94265528667;11525.308481491138;11793.823092653445;9465.716028519155;11943.581974630846;12160.878391215974;12171.39143042862;12256.509739610316;8100.594970251346;8223.592876125482;8468.745937621881;8530.74407767768;8553.503136950883;10958.780824383308;11860.110491713329;12005;12035.578754743541;12103.818442723543 05:31:55 INFO - PROCESS | 1664 | |3;mootools.html;1486.7398205314066;1618.4335482581093;1654.743514755213;1694.5340031491346;2111.5776844631077;8072.152423995477;8703.738887833359;8911.108889111085;8916.598753056112;8932.151445612673;8626.439281446701;8890.86663700045;8895.777605559848;8915.465072095678;8952.8657070144;2253.752087270399;2483.801295896333;2533.2526904563106;2537.6574162488105;2578.0847799031353;2569.743025697425;2577.896884124633;2581.4707984863057;2585.9741402586014;2586.030238660502;2456.1649039326626;2468.617364308535;2469.753024697525;2469.987650061756;2470.209532949457;2047.2834507922257;2446.7675570820743;2536.441982763798;2551.1581178211145;2555.897764089434;2482.3918140055803;2510.987445062763;2528;2532.5061612985473;2537.555927712643;8889.555522223927;8976.910230897673;8985.820283594358;8991;8996.460212387212;5479.808206712786;5634.577406694473;5640.915386269168;5642.125470552071;5643.492085712305;3546.733994950363;3645.963540364589;3693.0582701411236;3704.518412606344;3713.721470889694;1026.2098184397971;1045.1795340657623;1067.8344856547249;1075.4031512510553;1080.6325849211305;12014.879851201551;12018.278903265833;12022.51909923602;12047.759044819055;12063.155579109465;4893.969002863842;4913.508649135058;4983.5763960063805;4989.376327959005;5011.398632164163;9454.196393306645;9489.667861624948;10261.179105671528;10263.640772572924;10279.537420816081;5558.416366281483;5564.137558678412;5572.860678482989;5577.9442205577425;5582.134769110794;4502.729836209838;4617.492075871652;4670.719756814534;4686.601638860735;4784.330193772875;3351.7151042161204;3950.5654378018394;4022.959770402317;4082.2651922653613;4089.734167279117;1308.4373719300602;1339.912905661129;1343;1347.4610155937703;1357.016163281613;1369.3564024908278;1393.979090313646;1414.0737816729852;1426.892983026277;1428.0646176754242;7040.788776336718;8289.709860154986;8440.40917135807;8465.365097617703;8487.405881588353;1228.1648479034343;1234.4444999750149;1259.2885019963692;1259.8236246925437;1266.7149891274573;6350.428461438492;6375.203099612549;6434.034894765729;6443.7744678936015;6445.51658625605;10342;10817.513211905325;10823.83764243537;10829.24195306321;10841.403722795321;10503.474826258656;10779.461026948622;10782.892171078345;10841.241113122163;10893.618723344645;8467.237948584658;8480.703175388831;8492.235698787139;8554.230119289294;8627.705844123306;7929.722459713882;7951.801204969922;8030.076541197837;8031.879521807061;8058.597070146352;7838.686452541834;9477.289203309641;9718.416894986323;9750.609975600897;9768.169705574821;9858.950705246429;10016.39901605906;10198.031187037219;10202.41862511312;10266.743331416774;7062.1878483975;7080.539764915264;7126.643667816485;7172.13934327884;7185.9939608453815;8234.876476852733;8256.917430825615;8304.086550479322;8307.460015098999;8308.750737477885;6012.579119461596;7485.737999170003;7537.434692398202;7666.271704188093;7669.69321227167;5606;6752.426043786137;7370.189279179393;7412.888806668012;7491.325780679547;7113.359797618239;7638.656260468403;7793.337566306701;7831.921680783119;7864.134945156143;6057.363976782374;7078.327558881898;7084.326988936043;7125.608091555015;7131.358177764027;7129.714811407485;7160.820979475347;7182;7209;7211.747588834365 05:31:55 INFO - PROCESS | 1664 | |4;prototype.html;301.58532018474597;332.5693227270685;340.5504733751446;342.4520766773163;345.29387402761364;6529.7677649563475;6549.279579246279;6558.409743123118;6596.373344532274;6602.86794264115;6462.903056454157;6474.0612611171355;6476.255230648477;6503.447206987412;6539.509536784736;3847.3267178243836;4612.331211974261;4773.140834649762;4798.47216806151;4836.371271734678;4779.091972525226;4787.880302992436;4796.736179510125;4812.759362031902;4813.614910807145;4755.762211889409;4787.640926930477;4789.592884604813;4795.592374648159;4799.976000120012;4572.748498832563;4636.35091087248;4692.953070469286;4704.5765881070865;4704.741239231858;4113.958860411388;4126.628603425676;4129.793510324502;4130.132672138854;4143.523494798107;5231.110711179109;6097.969510152465;6231.096491008779;6232.002879539252;6252.3122456529745;5721.256236689245;5722.713864306768;5725.427457254283;5730.283714535683;5734.340550836666;6296.614744756146;7003.2296447390745;7018.578885266849;7020.333068358498;7021.262767409451;4113.362428823537;4544.909101817978;4546.340780586796;4551.158035763395;4551.613112885409;6117.510599152101;7044.7534336298495;7252.404471016368;7313.341799238041;7340.889886651705;4611.976940115278;4642.489326174118;4644.651651126179;4649.651276154302;4650.5349465053905;4699.459562150397;4709.764511774398;4710.505396933341;4717.363155973968;4725.007748372812;5642.351129620064;5643.209950606836;5646.265985421869;5646.322441307069;5651.632643878134;6709.630970296583;6983.580985140908;7057.117860267466;7066.328698773608;7099.929000709927;1468.5814542855235;1489.7765335199806;1613.4917500987385;1618.5387164658016;1618.8785841061967;1033.8317700997975;1036.0416614631436;1056.2395075545749;1057.1965306367063;1060.9469526523797;5734.512566431817;5973.49225315853;6478.643674597848;6545.967270163619;6663.900041499382;7346.5592064476305;7351;7351.301626345488;7356.521826081287;7368.557886526718;6658.86682266352;6693.163354580677;6701.0953521274005;6708.765193218214;6719.596824190564;2802.075315145997;3825.3688141456905;3858.1897801462005;3859.0931131184147;3871.477350557695;7449.776506704808;7704.882791995242;7706.460547761603;7721.45949783521;7739.380849532024;6118.724657390429;7484.401247900155;7533.660985255677;7554.320111190019;7561.659725312375;7688.769336919901;7697.499662521918;7702.152763196156;7704.499207551491;7710.151883292833;7282.45381596393;7290.744823931137;7293.890591641023;7299.233580473974;7308;6936.098307220029;7207.891881621675;7233.529820561646;7237;7261.128664560287;6700.229473610597;7368.263173682803;7700.8844867325915;7710.961445192963;7740.225977402215;4638.002829391562;4654.581087702123;4655.883602909819;4661;4665.066986602761;5897.911531326948;6266.373362663697;6963.895541566779;7254.274572542915;7256.23809500016;6687.76592819249;7000.50996430245;7004.789856304115;7006.824829379307;7042.929570704227;6966.338197871194;6971.5468494547695;6972.511924165463;7000;7011.053507776385;6781.609769997237;6820.93179068203;6822.829429264308;6831.795046148623;6841.350071743176;6991.475639326969;6995.615241161785;7009.088818453773;7034.507584469038;7035.824104397227;6520;6524.836879078061;6684.4318232950745;6778.627175505395;6787.151606049244 05:31:55 INFO - PROCESS | 1664 | |5;yui.html;683.8905775075989;704.3907020427331;728.1553398058253;729.6278897762141;792.5046845721424;15159.92420037901;15179.924100379496;15316.157611331373;15349.386024559031;15405.152716600596;12967.027472939544;13667.179969201854;13731.313434328293;13762.38069286882;13856.445742170301;970.3983530211261;1008.369768894441;1012.0385633648027;1012.5241136665792;1016.4968340671378;954.7565370830463;988.8269552828226;995.6316163019693;997.7804882925744;1009.0565321424492;839.4627438439404;1037.667946257198;1061.7080302916681;1065.440643662076;1066.072516910289;1045.7333379988092;1046.5342922399536;1048.2138396202772;1051.3534176481485;1051.5215576912487;780.4146889832625;781.4568874632133;782.0185666987951;783.2793829676712;783.91768864269;15108.169050702207;15153.924230378887;15195.392184312614;15198.924005380013;15204.543863684106;10504.789904201949;12203.145779795417;12351;12634.2419454833;12689.492420303177;10278;10330.793384132276;10335.483225838752;10668.413237271947;11082.556697732081;3502.2995400919663;3572.3391172633146;3577.463380492921;3629.909252268688;3702.3705969985167;78385.2161478378;78824.60587697082;79125.60437197835;79160;79204.41591168144;9493.193078588398;9807.852882206773;10089.545970431349;10099.990000999842;10221.642242521477;23353.649695254586;23421.53156936852;23714.288571342888;23907.924143413587;23969.880150599136;7519.661615227328;7583;7676;7808.297253247235;7942;3986.382110772835;4044.4337792709043;4060.939085913714;4101.118259574206;4214.1150358425075;3603.5135256740527;3618.9638103619154;3638.1450359165574;3638.872639457606;3654.3970244909824;614.8555089553952;618.536097926555;625.8140823140214;684.2712511175681;691.6645426967916;574.184657785945;608.5466327585976;619.4053708439948;620.4478014567039;620.8106527509062;8123.431359804875;8361.707340243061;8405.201505856934;8443.57782110892;8549.27331176857;498.1431937068237;603.414687752879;610.0026456743257;620.3269452643842;620.9875802483925;3888.066863952631;3895.2988462077096;3973.6821054315587;4215.051613386963;4222.282212023963;102037.48981255195;103179.93640127155;103490.48254758678;104518;105453;66059;67185.99221011689;81146.18853811386;84694.5765271182;85351.5732421334;71641.92537111948;72591.63704181551;74787.62606187043;75767.62116189495;75927.62036189783;7874.251946065115;8057;8065.314448271963;8095.595220239083;8153.592320384076;47313.763431182626;47335.52664473311;48538.5146148534;50021.49978500168;53001.93996120133;55444;64537.03194452181;71060;76170.6191469039;77293.2270677286;10118.544665490217;10376.991062066452;10468.371897686164;10491.895081049091;10533.841992369968;11087.501062452047;11199.66401007971;11362.94318528402;11445.198836081394;11603.245789023686;9500.95249523748;10116.797664046531;10772.515236814206;10800.24398292112;11144.442777860912;10069.748256293651;10519.737006574896;10585.417802020962;10878.94560527224;10899.836502452628;10236.539355729159;10480.213983951082;10718.724212326408;10798.946005270238;10953.780924381308;9018.323625727966;9039.141281578239;9136.634534618806;9368.67209647659;9394.154526092685;8935.687250946186;9052.54737263121;9053.275737941081;9167.220786233245;9251.953740231256 05:31:55 INFO - PROCESS | 1664 | __end_tp_report 05:31:55 INFO - PROCESS | 1664 | __start_cc_report 05:31:55 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,990 05:31:55 INFO - PROCESS | 1664 | __end_cc_report 05:31:55 INFO - PROCESS | 1664 | __startTimestamp1460637115049__endTimestamp 05:31:55 INFO - PROCESS | 1664 | 05:31:55 INFO - PROCESS | 1664 | ------- Summary: start ------- 05:31:55 INFO - PROCESS | 1664 | Number of tests: 6 05:31:55 INFO - PROCESS | 1664 | 05:31:55 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5702.33 Median:5873.82 stddev:634.86 (10.8%) stddev-sans-first:611.31 05:31:55 INFO - PROCESS | 1664 | Values: 3431.8 3476.4 3492.0 3512.9 3543.3 5616.1 5637.6 5662.9 5663.8 5664.0 5624.0 5650.5 5664.2 5674.0 5674.5 5035.7 5083.7 5095.1 5148.8 5160.3 5221.6 5236.5 5237.7 5241.0 5243.3 5117.1 5155.5 5192.8 5197.5 5200.0 5184.3 5226.9 5233.9 5241.6 5270.2 4889.5 5022.2 5035.6 5066.5 5144.8 5570.6 5581.6 5608.2 5609.5 5614.9 6079.8 6220.8 6250.1 6252.5 6259.2 6189.1 6224.1 6281.2 6323.4 6363.0 5733.2 5759.8 5765.5 5797.7 5798.9 6262.2 6286.7 6369.3 6386.6 6400.3 6093.8 6106.8 6123.0 6130.9 6136.8 6250.6 6264.9 6269.9 6272.1 6277.7 6039.5 6119.7 6139.8 6201.5 6202.4 6133.5 6187.0 6204.8 6206.1 6210.8 4858.1 4863.4 4865.1 4870.0 4879.6 4330.3 4389.6 4404.3 4406.2 4451.3 5673.5 5709.6 5727.4 5731.1 5739.9 6126.1 6165.8 6166.0 6175.4 6185.0 5704.0 5735.9 5743.2 5773.9 5779.9 4585.7 5345.1 5367.8 5369.7 5394.2 6262.1 6292.4 6359.1 6361.7 6364.5 6245.8 6298.9 6300.4 6301.1 6304.7 6289.3 6312.0 6325.1 6345.7 6359.1 5182.2 5921.9 5994.3 6097.0 6121.2 6104.8 6130.5 6255.8 6256.5 6267.2 6017.0 6036.3 6050.4 6051.8 6068.6 5805.3 5873.8 5963.3 5993.7 6045.0 5862.8 5869.0 5879.5 5885.6 5891.1 5332.4 5927.7 6047.2 6051.7 6056.8 5698.5 5824.6 5879.0 5883.1 5889.4 05:31:55 INFO - PROCESS | 1664 | 05:31:55 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:61004.78 Median:208544.50 stddev:121396.15 (58.2%) stddev-sans-first:121651.67 05:31:55 INFO - PROCESS | 1664 | Values: 488.0 591.0 591.9 650.2 657.5 28719.7 34990.3 37442.4 39592.0 39814.8 42461.9 43210.4 43254.4 43255.0 43414.0 9650.2 9846.5 9875.9 9882.4 9890.5 9668.0 9843.3 9846.0 9852.6 9853.9 9764.9 9944.7 9951.5 9974.9 10008.2 9854.7 9908.8 9931.3 9953.9 9961.4 9713.6 9861.2 9864.7 9866.9 9879.9 34266.0 41138.0 41482.4 41579.2 41613.6 3334.7 3352.6 3475.0 3486.3 3920.5 26246.9 27257.2 27307.7 27335.7 27587.7 2511.0 2513.7 2719.5 2763.0 2787.3 412905.0 414731.0 416670.0 418709.0 419581.0 64759.7 64976.0 65093.7 65144.3 65182.0 66679.3 74813.0 75875.2 76196.2 76283.9 18094.0 18153.3 18205.3 18308.8 18332.0 13865.3 13933.9 13947.8 13960.5 13968.2 19407.4 20358.2 21696.0 21885.8 21956.0 7550.5 7612.7 7808.8 8877.5 9012.2 921.9 982.5 1105.4 1147.6 1200.1 29919.9 30077.1 30259.7 30762.0 30782.8 1111.2 1118.9 1165.9 1201.0 1202.2 15442.5 15461.8 15508.7 15577.6 15655.2 554006.0 556304.0 557565.0 558631.0 559006.0 61557.0 62220.1 62281.4 62341.0 62375.0 1294.8 1434.3 1535.5 1587.0 1630.7 24633.6 29071.3 29152.7 29937.7 30060.0 48886.8 49270.0 49565.5 49744.8 49787.5 377046.0 378243.0 378737.0 379130.0 379641.0 28860.3 30629.0 34752.8 34947.0 35371.5 42636.4 44139.8 47911.5 49175.3 49834.0 36956.0 37959.0 39781.2 40804.8 41151.2 36353.5 37000.4 37185.6 37453.1 37707.2 36657.8 36717.3 37306.6 37912.4 38039.6 32114.2 32303.5 32929.0 33030.0 33111.8 21804.6 25527.9 26071.1 26166.9 26284.7 05:31:55 INFO - PROCESS | 1664 | 05:31:55 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:36529.03 Median:21162.95 stddev:112031.14 (529.4%) stddev-sans-first:112312.53 05:31:55 INFO - PROCESS | 1664 | Values: 375.5 378.6 378.9 381.8 386.3 20062.3 20489.7 20911.4 21150.9 21175.0 20419.7 20730.5 21304.6 21385.7 21635.9 5257.4 5459.2 5467.9 5495.8 5497.6 3991.1 5791.8 6046.6 6046.8 6057.2 5955.3 6003.2 6029.8 6049.9 6052.5 5883.5 6029.5 6069.6 6074.4 6090.4 5408.1 5769.0 5777.1 5787.9 5789.5 13529.4 13698.7 13762.6 13793.3 13797.4 2162.9 2206.2 2322.5 2411.8 2633.2 9797.1 10051.6 10163.5 10292.2 10536.3 1746.5 1788.4 1800.7 1844.4 1955.5 90041.1 104301.5 104635.5 106298.5 112197.3 9129.3 10995.1 11408.7 11755.0 11834.7 14591.7 14651.9 14700.9 14716.3 14724.4 8824.2 8835.6 8878.2 9001.3 9096.1 7548.0 8248.8 8435.7 9222.9 9339.5 3757.5 4557.8 4627.3 4663.6 4685.5 1809.7 1826.2 1860.0 1920.9 1969.6 924.9 931.6 1016.6 1032.4 1037.6 20498.6 20805.6 21465.6 21487.0 21516.4 984.8 1016.6 1028.9 1071.3 1088.0 11217.6 11588.9 11613.0 11615.5 11624.9 667098.0 668379.0 670740.0 685470.0 689861.0 128202.0 130338.0 134822.6 135530.0 137295.0 1032.6 1041.8 1046.9 1060.3 1063.2 18327.5 18795.5 18933.5 19085.4 19611.2 40269.4 51691.7 53056.5 53556.7 53736.7 69262.0 70503.0 70714.3 71159.0 75504.2 7010.6 8198.0 8266.7 8380.2 8419.0 13268.9 13606.8 13612.0 13836.8 13868.2 11756.5 11766.2 11846.2 11976.0 12038.9 11267.2 11295.8 11468.9 11525.3 11793.8 9465.7 11943.6 12160.9 12171.4 12256.5 8100.6 8223.6 8468.7 8530.7 8553.5 10958.8 11860.1 12005.0 12035.6 12103.8 05:31:55 INFO - PROCESS | 1664 | 05:31:55 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:6095.09 Median:5000.39 stddev:3185.23 (63.7%) stddev-sans-first:3175.33 05:31:55 INFO - PROCESS | 1664 | Values: 1486.7 1618.4 1654.7 1694.5 2111.6 8072.2 8703.7 8911.1 8916.6 8932.2 8626.4 8890.9 8895.8 8915.5 8952.9 2253.8 2483.8 2533.3 2537.7 2578.1 2569.7 2577.9 2581.5 2586.0 2586.0 2456.2 2468.6 2469.8 2470.0 2470.2 2047.3 2446.8 2536.4 2551.2 2555.9 2482.4 2511.0 2528.0 2532.5 2537.6 8889.6 8976.9 8985.8 8991.0 8996.5 5479.8 5634.6 5640.9 5642.1 5643.5 3546.7 3646.0 3693.1 3704.5 3713.7 1026.2 1045.2 1067.8 1075.4 1080.6 12014.9 12018.3 12022.5 12047.8 12063.2 4894.0 4913.5 4983.6 4989.4 5011.4 9454.2 9489.7 10261.2 10263.6 10279.5 5558.4 5564.1 5572.9 5577.9 5582.1 4502.7 4617.5 4670.7 4686.6 4784.3 3351.7 3950.6 4023.0 4082.3 4089.7 1308.4 1339.9 1343.0 1347.5 1357.0 1369.4 1394.0 1414.1 1426.9 1428.1 7040.8 8289.7 8440.4 8465.4 8487.4 1228.2 1234.4 1259.3 1259.8 1266.7 6350.4 6375.2 6434.0 6443.8 6445.5 10342.0 10817.5 10823.8 10829.2 10841.4 10503.5 10779.5 10782.9 10841.2 10893.6 8467.2 8480.7 8492.2 8554.2 8627.7 7929.7 7951.8 8030.1 8031.9 8058.6 7838.7 9477.3 9718.4 9750.6 9768.2 9859.0 10016.4 10198.0 10202.4 10266.7 7062.2 7080.5 7126.6 7172.1 7186.0 8234.9 8256.9 8304.1 8307.5 8308.8 6012.6 7485.7 7537.4 7666.3 7669.7 5606.0 6752.4 7370.2 7412.9 7491.3 7113.4 7638.7 7793.3 7831.9 7864.1 6057.4 7078.3 7084.3 7125.6 7131.4 7129.7 7160.8 7182.0 7209.0 7211.7 05:31:55 INFO - PROCESS | 1664 | 05:31:55 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5703.48 Median:6491.05 stddev:1840.42 (28.4%) stddev-sans-first:1800.37 05:31:55 INFO - PROCESS | 1664 | Values: 301.6 332.6 340.6 342.5 345.3 6529.8 6549.3 6558.4 6596.4 6602.9 6462.9 6474.1 6476.3 6503.4 6539.5 3847.3 4612.3 4773.1 4798.5 4836.4 4779.1 4787.9 4796.7 4812.8 4813.6 4755.8 4787.6 4789.6 4795.6 4800.0 4572.7 4636.4 4693.0 4704.6 4704.7 4114.0 4126.6 4129.8 4130.1 4143.5 5231.1 6098.0 6231.1 6232.0 6252.3 5721.3 5722.7 5725.4 5730.3 5734.3 6296.6 7003.2 7018.6 7020.3 7021.3 4113.4 4544.9 4546.3 4551.2 4551.6 6117.5 7044.8 7252.4 7313.3 7340.9 4612.0 4642.5 4644.7 4649.7 4650.5 4699.5 4709.8 4710.5 4717.4 4725.0 5642.4 5643.2 5646.3 5646.3 5651.6 6709.6 6983.6 7057.1 7066.3 7099.9 1468.6 1489.8 1613.5 1618.5 1618.9 1033.8 1036.0 1056.2 1057.2 1060.9 5734.5 5973.5 6478.6 6546.0 6663.9 7346.6 7351.0 7351.3 7356.5 7368.6 6658.9 6693.2 6701.1 6708.8 6719.6 2802.1 3825.4 3858.2 3859.1 3871.5 7449.8 7704.9 7706.5 7721.5 7739.4 6118.7 7484.4 7533.7 7554.3 7561.7 7688.8 7697.5 7702.2 7704.5 7710.2 7282.5 7290.7 7293.9 7299.2 7308.0 6936.1 7207.9 7233.5 7237.0 7261.1 6700.2 7368.3 7700.9 7711.0 7740.2 4638.0 4654.6 4655.9 4661.0 4665.1 5897.9 6266.4 6963.9 7254.3 7256.2 6687.8 7000.5 7004.8 7006.8 7042.9 6966.3 6971.5 6972.5 7000.0 7011.1 6781.6 6820.9 6822.8 6831.8 6841.4 6991.5 6995.6 7009.1 7034.5 7035.8 6520.0 6524.8 6684.4 6778.6 6787.2 05:31:55 INFO - PROCESS | 1664 | 05:31:55 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:18631.68 Median:4052.69 stddev:26839.42 (662.3%) stddev-sans-first:26880.88 05:31:55 INFO - PROCESS | 1664 | Values: 683.9 704.4 728.2 729.6 792.5 15159.9 15179.9 15316.2 15349.4 15405.2 12967.0 13667.2 13731.3 13762.4 13856.4 970.4 1008.4 1012.0 1012.5 1016.5 954.8 988.8 995.6 997.8 1009.1 839.5 1037.7 1061.7 1065.4 1066.1 1045.7 1046.5 1048.2 1051.4 1051.5 780.4 781.5 782.0 783.3 783.9 15108.2 15153.9 15195.4 15198.9 15204.5 10504.8 12203.1 12351.0 12634.2 12689.5 10278.0 10330.8 10335.5 10668.4 11082.6 3502.3 3572.3 3577.5 3629.9 3702.4 78385.2 78824.6 79125.6 79160.0 79204.4 9493.2 9807.9 10089.5 10100.0 10221.6 23353.6 23421.5 23714.3 23907.9 23969.9 7519.7 7583.0 7676.0 7808.3 7942.0 3986.4 4044.4 4060.9 4101.1 4214.1 3603.5 3619.0 3638.1 3638.9 3654.4 614.9 618.5 625.8 684.3 691.7 574.2 608.5 619.4 620.4 620.8 8123.4 8361.7 8405.2 8443.6 8549.3 498.1 603.4 610.0 620.3 621.0 3888.1 3895.3 3973.7 4215.1 4222.3 102037.5 103179.9 103490.5 104518.0 105453.0 66059.0 67186.0 81146.2 84694.6 85351.6 71641.9 72591.6 74787.6 75767.6 75927.6 7874.3 8057.0 8065.3 8095.6 8153.6 47313.8 47335.5 48538.5 50021.5 53001.9 55444.0 64537.0 71060.0 76170.6 77293.2 10118.5 10377.0 10468.4 10491.9 10533.8 11087.5 11199.7 11362.9 11445.2 11603.2 9501.0 10116.8 10772.5 10800.2 11144.4 10069.7 10519.7 10585.4 10878.9 10899.8 10236.5 10480.2 10718.7 10798.9 10953.8 9018.3 9039.1 9136.6 9368.7 9394.2 8935.7 9052.5 9053.3 9167.2 9252.0 05:31:55 INFO - PROCESS | 1664 | -------- Summary: end -------- 05:31:55 INFO - PROCESS | 1664 | 05:31:55 INFO - TEST-INFO | 1664: exit 0 05:31:55 INFO - TEST-OK | dromaeo_css | took 1113428ms 05:31:55 INFO - TEST-START | kraken 05:31:55 INFO - operating with platform_type : mac_ 05:31:55 INFO - Initialising browser for kraken test... 05:31:55 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpcfkSyP/profile http://localhost:49275/getInfo.html) 05:31:57 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 05:31:57 INFO - PROCESS | 1672 | colorDepth:24 05:31:57 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 05:31:57 INFO - PROCESS | 1672 | __metrics 05:31:57 INFO - PROCESS | 1672 | 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:31:57 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:58 INFO - TEST-INFO | 1672: exit 0 05:31:58 INFO - Browser initialized. 05:31:58 INFO - Running cycle 1/1 for kraken test... 05:31:58 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpcfkSyP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:10 INFO - PROCESS | 1674 | RSS: Main: 207802368 05:32:10 INFO - PROCESS | 1674 | 05:32:13 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 05:32:13 INFO - PROCESS | 1674 | RSS: Main: 262975488 05:32:13 INFO - PROCESS | 1674 | 05:32:16 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 05:32:16 INFO - PROCESS | 1674 | RSS: Main: 273145856 05:32:16 INFO - PROCESS | 1674 | 05:32:19 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 05:32:20 INFO - PROCESS | 1674 | RSS: Main: 263741440 05:32:20 INFO - PROCESS | 1674 | 05:32:22 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 05:32:23 INFO - PROCESS | 1674 | RSS: Main: 265101312 05:32:23 INFO - PROCESS | 1674 | 05:32:25 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:32:26 INFO - PROCESS | 1674 | RSS: Main: 265924608 05:32:26 INFO - PROCESS | 1674 | 05:32:28 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 05:32:29 INFO - PROCESS | 1674 | RSS: Main: 265850880 05:32:29 INFO - PROCESS | 1674 | 05:32:32 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 05:32:32 INFO - PROCESS | 1674 | RSS: Main: 265916416 05:32:32 INFO - PROCESS | 1674 | 05:32:35 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 05:32:36 INFO - PROCESS | 1674 | RSS: Main: 266391552 05:32:36 INFO - PROCESS | 1674 | 05:32:37 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:32:38 INFO - PROCESS | 1674 | RSS: Main: 299802624 05:32:38 INFO - PROCESS | 1674 | 05:32:40 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:32:40 INFO - PROCESS | 1674 | RSS: Main: 300933120 05:32:40 INFO - PROCESS | 1674 | 05:32:42 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:32:43 INFO - PROCESS | 1674 | RSS: Main: 305487872 05:32:43 INFO - PROCESS | 1674 | 05:32:46 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:32:46 INFO - PROCESS | 1674 | RSS: Main: 307585024 05:32:46 INFO - PROCESS | 1674 | 05:32:49 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:32:49 INFO - PROCESS | 1674 | RSS: Main: 307564544 05:32:49 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 05:32:51 INFO - PROCESS | 1674 | RSS: Main: 371253248 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | __start_tp_report 05:32:51 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 05:32:51 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 05:32:51 INFO - PROCESS | 1674 | |i|pagename|runs| 05:32:51 INFO - PROCESS | 1674 | |0;ai-astar;112;111;110;111;112;111;119;110;111;111 05:32:51 INFO - PROCESS | 1674 | |1;audio-beat-detection;156;122;141;158;118;140;116;151;145;116 05:32:51 INFO - PROCESS | 1674 | |2;audio-dft;187;184;187;188;186;186;187;185;187;185 05:32:51 INFO - PROCESS | 1674 | |3;audio-fft;74;101;109;160;55;56;57;57;116;58 05:32:51 INFO - PROCESS | 1674 | |4;audio-oscillator;90;97;134;78;88;122;155;85;78;124 05:32:51 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;90;85;88;87;89;84;88;85;89;85 05:32:51 INFO - PROCESS | 1674 | |6;imaging-darkroom;134;127;94;94;94;93;94;93;93;93 05:32:51 INFO - PROCESS | 1674 | |7;imaging-desaturate;86;85;100;132;136;88;86;87;85;84 05:32:51 INFO - PROCESS | 1674 | |8;json-parse-financial;57;62;59;59;58;58;59;71;53;52 05:32:51 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;62;62;80;73;70;68;67;66;66;67 05:32:51 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;82;79;70;96;98;105;92;80;79;83 05:32:51 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;116;119;130;129;116;120;102;124;125;128 05:32:51 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;135;134;133;133;132;122;133;133;133;135 05:32:51 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;67;65;66;65;68;65;65;66;67;64 05:32:51 INFO - PROCESS | 1674 | __end_tp_report 05:32:51 INFO - PROCESS | 1674 | __start_cc_report 05:32:51 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1208 05:32:51 INFO - PROCESS | 1674 | __end_cc_report 05:32:51 INFO - PROCESS | 1674 | __startTimestamp1460637171561__endTimestamp 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | ------- Summary: start ------- 05:32:51 INFO - PROCESS | 1674 | Number of tests: 14 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.00 stddev:2.62 (2.4%) stddev-sans-first:2.77 05:32:51 INFO - PROCESS | 1674 | Values: 112.0 111.0 110.0 111.0 112.0 111.0 119.0 110.0 111.0 111.0 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:143.00 stddev:16.83 (11.8%) stddev-sans-first:16.27 05:32:51 INFO - PROCESS | 1674 | Values: 156.0 122.0 141.0 158.0 118.0 140.0 116.0 151.0 145.0 116.0 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:186.20 Median:187.00 stddev:1.23 (0.7%) stddev-sans-first:1.27 05:32:51 INFO - PROCESS | 1674 | Values: 187.0 184.0 187.0 188.0 186.0 186.0 187.0 185.0 187.0 185.0 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:84.30 Median:56.50 stddev:35.86 (63.5%) stddev-sans-first:37.84 05:32:51 INFO - PROCESS | 1674 | Values: 74.0 101.0 109.0 160.0 55.0 56.0 57.0 57.0 116.0 58.0 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:81.50 stddev:26.72 (32.8%) stddev-sans-first:27.78 05:32:51 INFO - PROCESS | 1674 | Values: 90.0 97.0 134.0 78.0 88.0 122.0 155.0 85.0 78.0 124.0 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.00 stddev:2.11 (2.4%) stddev-sans-first:1.94 05:32:51 INFO - PROCESS | 1674 | Values: 90.0 85.0 88.0 87.0 89.0 84.0 88.0 85.0 89.0 85.0 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:100.90 Median:93.50 stddev:15.69 (16.8%) stddev-sans-first:11.18 05:32:51 INFO - PROCESS | 1674 | Values: 134.0 127.0 94.0 94.0 94.0 93.0 94.0 93.0 93.0 93.0 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:85.50 stddev:20.10 (23.5%) stddev-sans-first:20.93 05:32:51 INFO - PROCESS | 1674 | Values: 86.0 85.0 100.0 132.0 136.0 88.0 86.0 87.0 85.0 84.0 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:59.00 stddev:5.20 (8.8%) stddev-sans-first:5.48 05:32:51 INFO - PROCESS | 1674 | Values: 57.0 62.0 59.0 59.0 58.0 58.0 59.0 71.0 53.0 52.0 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:67.50 stddev:5.32 (7.9%) stddev-sans-first:5.17 05:32:51 INFO - PROCESS | 1674 | Values: 62.0 62.0 80.0 73.0 70.0 68.0 67.0 66.0 66.0 67.0 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:82.50 stddev:10.82 (13.1%) stddev-sans-first:11.36 05:32:51 INFO - PROCESS | 1674 | Values: 82.0 79.0 70.0 96.0 98.0 105.0 92.0 80.0 79.0 83.0 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:124.50 stddev:8.40 (6.7%) stddev-sans-first:8.72 05:32:51 INFO - PROCESS | 1674 | Values: 116.0 119.0 130.0 129.0 116.0 120.0 102.0 124.0 125.0 128.0 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.30 Median:133.00 stddev:3.74 (2.8%) stddev-sans-first:3.84 05:32:51 INFO - PROCESS | 1674 | Values: 135.0 134.0 133.0 133.0 132.0 122.0 133.0 133.0 133.0 135.0 05:32:51 INFO - PROCESS | 1674 | 05:32:51 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.23 (1.9%) stddev-sans-first:1.22 05:32:51 INFO - PROCESS | 1674 | Values: 67.0 65.0 66.0 65.0 68.0 65.0 65.0 66.0 67.0 64.0 05:32:51 INFO - PROCESS | 1674 | -------- Summary: end -------- 05:32:51 INFO - PROCESS | 1674 | 05:32:52 INFO - TEST-INFO | 1674: exit 0 05:32:52 INFO - TEST-OK | kraken | took 56731ms 05:32:52 INFO - SUITE-END | took 1170s 05:32:52 INFO - Completed test suite (00:19:30) 05:32:52 INFO - javascript benchmark 05:32:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3431.8284085795713, 3476.374252634525, 3491.999999999999, 3512.8594856205755, 3543.255916257586, 5616.101423772197, 5637.577181711373, 5662.915056274159, 5663.801766938158, 5664.0, 5623.971880140603, 5650.51970582501, 5664.150377443386, 5674.00704876647, 5674.460926212003, 5035.672681275723, 5083.694978301295, 5095.082885080693, 5148.819791307305, 5160.2517634942915, 5221.556167725748, 5236.502532259429, 5237.73811309433, 5240.973795131019, 5243.344581927259, 5117.13008788505, 5155.484451554833, 5192.792288308463, 5197.454267301936, 5200.037992971313, 5184.300119483878, 5226.8693282667855, 5233.895322093536, 5241.580673546107, 5270.156774916033, 4889.5354941280875, 5022.246663000543, 5035.647504674675, 5066.518680725362, 5144.794208231666, 5570.5822063345, 5581.581381396411, 5608.186812912146, 5609.467100625434, 5614.887702245932, 6079.817605471843, 6220.813375598694, 6250.0624906263965, 6252.499800015988, 6259.186305780219, 6189.133521307021, 6224.128621992924, 6281.152044474029, 6323.399277068671, 6363.0, 5733.16869053989, 5759.798407055733, 5765.509931655814, 5797.710114494258, 5798.855028624318, 6262.185915830913, 6286.654234017173, 6369.26753423353, 6386.552941294158, 6400.263969643551, 6093.847653808691, 6106.786262480792, 6123.020316749388, 6130.877382452326, 6136.846578835565, 6250.624962502265, 6264.874702505925, 6269.8746025079245, 6272.1219029335925, 6277.654728989858, 6039.486643635252, 6119.746288422706, 6139.815805525842, 6201.472874805602, 6202.379762023762, 6133.457080270857, 6187.0, 6204.7828326008375, 6206.0690896365, 6210.844728881814, 4858.149823780825, 4863.440704318978, 4865.0999565079865, 4869.977304766039, 4879.609631229493, 4330.28550289205, 4389.648828093745, 4404.2512772828695, 4406.20688276107, 4451.265541185668, 5673.461021203062, 5709.628874123168, 5727.398623144593, 5731.083026715705, 5739.913901291484, 6126.142340072304, 6165.84585385369, 6166.044263139221, 6175.413335733098, 6184.969075154685, 5704.030314846486, 5735.9139612905, 5743.2246646703, 5773.931822612746, 5779.942200578024, 4585.747783871919, 5345.091334473149, 5367.838964831061, 5369.731513424391, 5394.163904594794, 6262.09199666055, 6292.433680968735, 6359.109724638462, 6361.745530178741, 6364.49084073273, 6245.750169993149, 6298.905516417166, 6300.401461861115, 6301.086342480223, 6304.65324407162, 6289.339619339903, 6312.0, 6325.1144839721555, 6345.746170153142, 6359.109724638647, 5182.24857395683, 5921.881562368642, 5994.310654274815, 6096.993995990611, 6121.173641558333, 6104.755809767559, 6130.47890929276, 6255.812325630239, 6256.499480041677, 6267.2165979252595, 6016.969915150396, 6036.275646922398, 6050.394960503914, 6051.848703782264, 6068.605540639845, 5805.303363596396, 5873.823785286449, 5963.314218864886, 5993.70031498432, 6044.972354699799, 5862.765489380377, 5868.970655146697, 5879.470847623735, 5885.646861188342, 5891.086881533369, 5332.440093790096, 5927.733252003584, 6047.244094488189, 6051.697415129138, 6056.848578785565, 5698.458646428749, 5824.621399609012, 5879.0, 5883.146943693055, 5889.411058894077], "unit": "score", "name": "dojo.html", "value": 5662.709830605116}, {"lowerIsBetter": false, "replicates": [488.040999436108, 591.0454615795489, 591.9378465261148, 650.1612919334059, 657.4937298280324, 28719.712802871964, 34990.3001939961, 37442.43836342457, 39592.0, 39814.800925995405, 42461.93845153873, 43210.351844722354, 43254.35118473225, 43255.0, 43414.0, 9650.227981761478, 9846.45844478557, 9875.851862222073, 9882.357646752975, 9890.456024918627, 9668.0, 9843.310968232227, 9845.950770246174, 9852.605895764162, 9853.901460985406, 9764.902350976507, 9944.6519371822, 9951.502424878727, 9974.850377244311, 10008.199344052495, 9854.704358869245, 9908.80182396348, 9931.304808663324, 9953.850692239623, 9961.352512086727, 9713.56288966991, 9861.211103111735, 9864.704058878246, 9866.901330986742, 9879.851802222973, 34266.0, 41138.0, 41482.377764333556, 41579.168416631495, 41613.58386416127, 3334.6665333466703, 3352.5641666583433, 3474.9652503474895, 3486.250456151914, 3920.4511368408444, 26246.86876565624, 27257.182284531496, 27307.72692273072, 27335.726642733516, 27587.72412275892, 2511.0332521978985, 2513.6983561972497, 2719.5011765640406, 2762.986185069062, 2787.2613757354115, 412905.0, 414731.0, 416670.0, 418709.0, 419581.0, 64759.67620161869, 64976.0, 65093.674531627985, 65144.34855651478, 65182.0, 66679.33320666828, 74813.0, 75875.24124758792, 76196.23803762002, 76283.85574216391, 18094.0, 18153.27386904509, 18205.27178912829, 18308.816911830978, 18332.0, 13865.306734663227, 13933.930330348487, 13947.790783138262, 13960.511382101578, 13968.231747253998, 19407.417777466697, 20358.18567257323, 21696.0, 21885.781142188695, 21956.011979460964, 7550.509216900884, 7612.657430415645, 7808.843823123506, 8877.493390111, 9012.233960113334, 921.8663293822358, 982.4940155819759, 1105.3975583307117, 1147.6155487911642, 1200.0579545057087, 29919.85040074786, 30077.09768706942, 30259.69740302613, 30762.0, 30782.846085769426, 1111.183280288987, 1118.8601424821898, 1165.8659254185877, 1201.0211677482823, 1202.2185579373302, 15442.536723898076, 15461.768073478906, 15508.654027776405, 15577.610559736097, 15655.217239137997, 554006.0, 556304.0, 557565.0, 558631.0, 559006.0, 61557.0, 62220.06669899955, 62281.44296392536, 62341.0, 62375.0, 1294.838145231846, 1434.3473719457622, 1535.5163123616026, 1587.016050048977, 1630.7390817469147, 24633.630495542224, 29071.273218169714, 29152.708472915, 29937.700622993492, 30060.0, 48886.75556622194, 49270.0, 49565.50434495609, 49744.75127624483, 49787.502124979736, 377046.0, 378243.0, 378737.0, 379130.0, 379641.0, 28860.27849303784, 30629.0, 34752.826235869674, 34946.9515914523, 35371.46942795809, 42636.360454592585, 44139.77930110329, 47911.520884790705, 49175.329868053064, 49834.0, 36956.0, 37959.0, 39781.2043759129, 40804.79597601993, 41151.176976460905, 36353.45469817902, 37000.44499332566, 37185.62814371822, 37453.06367340838, 37707.2458550822, 36657.816710916275, 36717.26565468729, 37306.6269337314, 37912.43131352977, 38039.61960380361, 32114.19714507156, 32303.51544726878, 32929.0, 33030.009099727045, 33111.83444082764, 21804.56390872142, 25527.872360638077, 26071.08751193775, 26166.86916565405, 26284.73715262823], "unit": "score", "name": "ext.html", "value": 20129.797115609406}, {"lowerIsBetter": false, "replicates": [375.47058647307296, 378.57788565749183, 378.9166383395652, 381.7823840410967, 386.329717939375, 20062.297819576317, 20489.692654610193, 20911.372658820223, 21150.89424552875, 21175.0, 20419.693704594443, 20730.481737956557, 21304.57390852182, 21385.679214811753, 21635.891820540914, 5257.421683614799, 5459.235707001023, 5467.890642187154, 5495.835124946258, 5497.642653227547, 3991.1419044905338, 5791.82624521265, 6046.576739628228, 6046.7883624073165, 6057.151998720161, 5955.285365756115, 6003.159557661931, 6029.788957386492, 6049.939500604982, 6052.515798736091, 5883.499902508292, 6029.457348838604, 6069.57512974092, 6074.3621919698235, 6090.360512146227, 5408.13469844823, 5768.990426675315, 5777.075667893159, 5787.913181302284, 5789.536837053068, 13529.391177396943, 13698.657533561642, 13762.587122386345, 13793.310334483236, 13797.379117939616, 2162.8918554072393, 2206.150632006673, 2322.547103314854, 2411.7588241175918, 2633.1837130489416, 9797.06927841854, 10051.597936082548, 10163.4918254087, 10292.176625869912, 10536.26246162769, 1746.5458980665119, 1788.4098247578268, 1800.7028840241344, 1844.3729132095152, 1955.4720225539168, 90041.09958900392, 104301.47849260781, 104635.47682261615, 106298.46850765774, 112197.31704024447, 9129.315301352424, 10995.120390368751, 11408.657740267805, 11755.000824929977, 11834.704132396586, 14591.73828056653, 14651.92674036623, 14700.852991470163, 14716.33776480061, 14724.411023558938, 8824.161704638049, 8835.55822208887, 8878.156575125353, 9001.324900632479, 9096.090390960851, 7548.0, 8248.8350232995, 8435.746927592181, 9222.86165707515, 9339.486328251876, 3757.511523501982, 4557.817687292471, 4627.305904114342, 4663.580277775017, 4685.508021657745, 1809.7375880497254, 1826.2488610703936, 1859.981400186008, 1920.9231630734614, 1969.5962327722782, 924.856647219682, 931.6273490603812, 1016.5781200801732, 1032.396048311731, 1037.64719995202, 20498.59002819965, 20805.583888322148, 21465.57068858614, 21487.0, 21516.354509364744, 984.8276551603441, 1016.5577973581516, 1028.8713910761155, 1071.314358810362, 1087.9564817407215, 11217.60738374153, 11588.94205528967, 11613.0, 11615.535378584931, 11624.88375116238, 667098.0, 668379.0, 670740.0, 685470.0, 689861.0, 128202.0, 130338.0, 134822.56242063158, 135530.0, 137295.0, 1032.5972870580479, 1041.8280983637615, 1046.9371837689764, 1060.2790102730216, 1063.1919740996898, 18327.54181145482, 18795.530111747317, 18933.526661833563, 19085.427437176906, 19611.215551378355, 40269.39595906005, 51691.74154129356, 53056.46943530515, 53556.73221633867, 53736.73131634317, 69262.0, 70503.0, 70714.29285707077, 71159.0, 75504.24495754972, 7010.579365238102, 8198.0, 8266.710665126691, 8380.161983801814, 8418.98972123349, 13268.93365533166, 13606.795898061338, 13612.0, 13836.792448113085, 13868.167909925436, 11756.529738810352, 11766.176367654181, 11846.229995050295, 11976.041916646473, 12038.939805300917, 11267.211295209258, 11295.830562541403, 11468.94265528667, 11525.308481491138, 11793.823092653445, 9465.716028519155, 11943.581974630846, 12160.878391215974, 12171.39143042862, 12256.509739610316, 8100.594970251346, 8223.592876125482, 8468.745937621881, 8530.74407767768, 8553.503136950883, 10958.780824383308, 11860.110491713329, 12005.0, 12035.578754743541, 12103.818442723543], "unit": "score", "name": "jquery.html", "value": 9544.853151148838}, {"lowerIsBetter": false, "replicates": [1486.7398205314066, 1618.4335482581093, 1654.743514755213, 1694.5340031491346, 2111.5776844631077, 8072.152423995477, 8703.738887833359, 8911.108889111085, 8916.598753056112, 8932.151445612673, 8626.439281446701, 8890.86663700045, 8895.777605559848, 8915.465072095678, 8952.8657070144, 2253.752087270399, 2483.801295896333, 2533.2526904563106, 2537.6574162488105, 2578.0847799031353, 2569.743025697425, 2577.896884124633, 2581.4707984863057, 2585.9741402586014, 2586.030238660502, 2456.1649039326626, 2468.617364308535, 2469.753024697525, 2469.987650061756, 2470.209532949457, 2047.2834507922257, 2446.7675570820743, 2536.441982763798, 2551.1581178211145, 2555.897764089434, 2482.3918140055803, 2510.987445062763, 2528.0, 2532.5061612985473, 2537.555927712643, 8889.555522223927, 8976.910230897673, 8985.820283594358, 8991.0, 8996.460212387212, 5479.808206712786, 5634.577406694473, 5640.915386269168, 5642.125470552071, 5643.492085712305, 3546.733994950363, 3645.963540364589, 3693.0582701411236, 3704.518412606344, 3713.721470889694, 1026.2098184397971, 1045.1795340657623, 1067.8344856547249, 1075.4031512510553, 1080.6325849211305, 12014.879851201551, 12018.278903265833, 12022.51909923602, 12047.759044819055, 12063.155579109465, 4893.969002863842, 4913.508649135058, 4983.5763960063805, 4989.376327959005, 5011.398632164163, 9454.196393306645, 9489.667861624948, 10261.179105671528, 10263.640772572924, 10279.537420816081, 5558.416366281483, 5564.137558678412, 5572.860678482989, 5577.9442205577425, 5582.134769110794, 4502.729836209838, 4617.492075871652, 4670.719756814534, 4686.601638860735, 4784.330193772875, 3351.7151042161204, 3950.5654378018394, 4022.959770402317, 4082.2651922653613, 4089.734167279117, 1308.4373719300602, 1339.912905661129, 1343.0, 1347.4610155937703, 1357.016163281613, 1369.3564024908278, 1393.979090313646, 1414.0737816729852, 1426.892983026277, 1428.0646176754242, 7040.788776336718, 8289.709860154986, 8440.40917135807, 8465.365097617703, 8487.405881588353, 1228.1648479034343, 1234.4444999750149, 1259.2885019963692, 1259.8236246925437, 1266.7149891274573, 6350.428461438492, 6375.203099612549, 6434.034894765729, 6443.7744678936015, 6445.51658625605, 10342.0, 10817.513211905325, 10823.83764243537, 10829.24195306321, 10841.403722795321, 10503.474826258656, 10779.461026948622, 10782.892171078345, 10841.241113122163, 10893.618723344645, 8467.237948584658, 8480.703175388831, 8492.235698787139, 8554.230119289294, 8627.705844123306, 7929.722459713882, 7951.801204969922, 8030.076541197837, 8031.879521807061, 8058.597070146352, 7838.686452541834, 9477.289203309641, 9718.416894986323, 9750.609975600897, 9768.169705574821, 9858.950705246429, 10016.39901605906, 10198.031187037219, 10202.41862511312, 10266.743331416774, 7062.1878483975, 7080.539764915264, 7126.643667816485, 7172.13934327884, 7185.9939608453815, 8234.876476852733, 8256.917430825615, 8304.086550479322, 8307.460015098999, 8308.750737477885, 6012.579119461596, 7485.737999170003, 7537.434692398202, 7666.271704188093, 7669.69321227167, 5606.0, 6752.426043786137, 7370.189279179393, 7412.888806668012, 7491.325780679547, 7113.359797618239, 7638.656260468403, 7793.337566306701, 7831.921680783119, 7864.134945156143, 6057.363976782374, 7078.327558881898, 7084.326988936043, 7125.608091555015, 7131.358177764027, 7129.714811407485, 7160.820979475347, 7182.0, 7209.0, 7211.747588834365], "unit": "score", "name": "mootools.html", "value": 5007.06306385364}, {"lowerIsBetter": false, "replicates": [301.58532018474597, 332.5693227270685, 340.5504733751446, 342.4520766773163, 345.29387402761364, 6529.7677649563475, 6549.279579246279, 6558.409743123118, 6596.373344532274, 6602.86794264115, 6462.903056454157, 6474.0612611171355, 6476.255230648477, 6503.447206987412, 6539.509536784736, 3847.3267178243836, 4612.331211974261, 4773.140834649762, 4798.47216806151, 4836.371271734678, 4779.091972525226, 4787.880302992436, 4796.736179510125, 4812.759362031902, 4813.614910807145, 4755.762211889409, 4787.640926930477, 4789.592884604813, 4795.592374648159, 4799.976000120012, 4572.748498832563, 4636.35091087248, 4692.953070469286, 4704.5765881070865, 4704.741239231858, 4113.958860411388, 4126.628603425676, 4129.793510324502, 4130.132672138854, 4143.523494798107, 5231.110711179109, 6097.969510152465, 6231.096491008779, 6232.002879539252, 6252.3122456529745, 5721.256236689245, 5722.713864306768, 5725.427457254283, 5730.283714535683, 5734.340550836666, 6296.614744756146, 7003.2296447390745, 7018.578885266849, 7020.333068358498, 7021.262767409451, 4113.362428823537, 4544.909101817978, 4546.340780586796, 4551.158035763395, 4551.613112885409, 6117.510599152101, 7044.7534336298495, 7252.404471016368, 7313.341799238041, 7340.889886651705, 4611.976940115278, 4642.489326174118, 4644.651651126179, 4649.651276154302, 4650.5349465053905, 4699.459562150397, 4709.764511774398, 4710.505396933341, 4717.363155973968, 4725.007748372812, 5642.351129620064, 5643.209950606836, 5646.265985421869, 5646.322441307069, 5651.632643878134, 6709.630970296583, 6983.580985140908, 7057.117860267466, 7066.328698773608, 7099.929000709927, 1468.5814542855235, 1489.7765335199806, 1613.4917500987385, 1618.5387164658016, 1618.8785841061967, 1033.8317700997975, 1036.0416614631436, 1056.2395075545749, 1057.1965306367063, 1060.9469526523797, 5734.512566431817, 5973.49225315853, 6478.643674597848, 6545.967270163619, 6663.900041499382, 7346.5592064476305, 7351.0, 7351.301626345488, 7356.521826081287, 7368.557886526718, 6658.86682266352, 6693.163354580677, 6701.0953521274005, 6708.765193218214, 6719.596824190564, 2802.075315145997, 3825.3688141456905, 3858.1897801462005, 3859.0931131184147, 3871.477350557695, 7449.776506704808, 7704.882791995242, 7706.460547761603, 7721.45949783521, 7739.380849532024, 6118.724657390429, 7484.401247900155, 7533.660985255677, 7554.320111190019, 7561.659725312375, 7688.769336919901, 7697.499662521918, 7702.152763196156, 7704.499207551491, 7710.151883292833, 7282.45381596393, 7290.744823931137, 7293.890591641023, 7299.233580473974, 7308.0, 6936.098307220029, 7207.891881621675, 7233.529820561646, 7237.0, 7261.128664560287, 6700.229473610597, 7368.263173682803, 7700.8844867325915, 7710.961445192963, 7740.225977402215, 4638.002829391562, 4654.581087702123, 4655.883602909819, 4661.0, 4665.066986602761, 5897.911531326948, 6266.373362663697, 6963.895541566779, 7254.274572542915, 7256.23809500016, 6687.76592819249, 7000.50996430245, 7004.789856304115, 7006.824829379307, 7042.929570704227, 6966.338197871194, 6971.5468494547695, 6972.511924165463, 7000.0, 7011.053507776385, 6781.609769997237, 6820.93179068203, 6822.829429264308, 6831.795046148623, 6841.350071743176, 6991.475639326969, 6995.615241161785, 7009.088818453773, 7034.507584469038, 7035.824104397227, 6520.0, 6524.836879078061, 6684.4318232950745, 6778.627175505395, 6787.151606049244], "unit": "score", "name": "prototype.html", "value": 5088.2287966308395}, {"lowerIsBetter": false, "replicates": [683.8905775075989, 704.3907020427331, 728.1553398058253, 729.6278897762141, 792.5046845721424, 15159.92420037901, 15179.924100379496, 15316.157611331373, 15349.386024559031, 15405.152716600596, 12967.027472939544, 13667.179969201854, 13731.313434328293, 13762.38069286882, 13856.445742170301, 970.3983530211261, 1008.369768894441, 1012.0385633648027, 1012.5241136665792, 1016.4968340671378, 954.7565370830463, 988.8269552828226, 995.6316163019693, 997.7804882925744, 1009.0565321424492, 839.4627438439404, 1037.667946257198, 1061.7080302916681, 1065.440643662076, 1066.072516910289, 1045.7333379988092, 1046.5342922399536, 1048.2138396202772, 1051.3534176481485, 1051.5215576912487, 780.4146889832625, 781.4568874632133, 782.0185666987951, 783.2793829676712, 783.91768864269, 15108.169050702207, 15153.924230378887, 15195.392184312614, 15198.924005380013, 15204.543863684106, 10504.789904201949, 12203.145779795417, 12351.0, 12634.2419454833, 12689.492420303177, 10278.0, 10330.793384132276, 10335.483225838752, 10668.413237271947, 11082.556697732081, 3502.2995400919663, 3572.3391172633146, 3577.463380492921, 3629.909252268688, 3702.3705969985167, 78385.2161478378, 78824.60587697082, 79125.60437197835, 79160.0, 79204.41591168144, 9493.193078588398, 9807.852882206773, 10089.545970431349, 10099.990000999842, 10221.642242521477, 23353.649695254586, 23421.53156936852, 23714.288571342888, 23907.924143413587, 23969.880150599136, 7519.661615227328, 7583.0, 7676.0, 7808.297253247235, 7942.0, 3986.382110772835, 4044.4337792709043, 4060.939085913714, 4101.118259574206, 4214.1150358425075, 3603.5135256740527, 3618.9638103619154, 3638.1450359165574, 3638.872639457606, 3654.3970244909824, 614.8555089553952, 618.536097926555, 625.8140823140214, 684.2712511175681, 691.6645426967916, 574.184657785945, 608.5466327585976, 619.4053708439948, 620.4478014567039, 620.8106527509062, 8123.431359804875, 8361.707340243061, 8405.201505856934, 8443.57782110892, 8549.27331176857, 498.1431937068237, 603.414687752879, 610.0026456743257, 620.3269452643842, 620.9875802483925, 3888.066863952631, 3895.2988462077096, 3973.6821054315587, 4215.051613386963, 4222.282212023963, 102037.48981255195, 103179.93640127155, 103490.48254758678, 104518.0, 105453.0, 66059.0, 67185.99221011689, 81146.18853811386, 84694.5765271182, 85351.5732421334, 71641.92537111948, 72591.63704181551, 74787.62606187043, 75767.62116189495, 75927.62036189783, 7874.251946065115, 8057.0, 8065.314448271963, 8095.595220239083, 8153.592320384076, 47313.763431182626, 47335.52664473311, 48538.5146148534, 50021.49978500168, 53001.93996120133, 55444.0, 64537.03194452181, 71060.0, 76170.6191469039, 77293.2270677286, 10118.544665490217, 10376.991062066452, 10468.371897686164, 10491.895081049091, 10533.841992369968, 11087.501062452047, 11199.66401007971, 11362.94318528402, 11445.198836081394, 11603.245789023686, 9500.95249523748, 10116.797664046531, 10772.515236814206, 10800.24398292112, 11144.442777860912, 10069.748256293651, 10519.737006574896, 10585.417802020962, 10878.94560527224, 10899.836502452628, 10236.539355729159, 10480.213983951082, 10718.724212326408, 10798.946005270238, 10953.780924381308, 9018.323625727966, 9039.141281578239, 9136.634534618806, 9368.67209647659, 9394.154526092685, 8935.687250946186, 9052.54737263121, 9053.275737941081, 9167.220786233245, 9251.953740231256], "unit": "score", "name": "yui.html", "value": 7006.583424833242}], "name": "dromaeo_css", "value": 7610.047977851568}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 110.0, 111.0, 112.0, 111.0, 119.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [156.0, 122.0, 141.0, 158.0, 118.0, 140.0, 116.0, 151.0, 145.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 136.3}, {"lowerIsBetter": true, "replicates": [187.0, 184.0, 187.0, 188.0, 186.0, 186.0, 187.0, 185.0, 187.0, 185.0], "unit": "score", "name": "audio-dft", "value": 186.2}, {"lowerIsBetter": true, "replicates": [74.0, 101.0, 109.0, 160.0, 55.0, 56.0, 57.0, 57.0, 116.0, 58.0], "unit": "score", "name": "audio-fft", "value": 84.3}, {"lowerIsBetter": true, "replicates": [90.0, 97.0, 134.0, 78.0, 88.0, 122.0, 155.0, 85.0, 78.0, 124.0], "unit": "score", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [90.0, 85.0, 88.0, 87.0, 89.0, 84.0, 88.0, 85.0, 89.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.0}, {"lowerIsBetter": true, "replicates": [134.0, 127.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 100.9}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 100.0, 132.0, 136.0, 88.0, 86.0, 87.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [57.0, 62.0, 59.0, 59.0, 58.0, 58.0, 59.0, 71.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 58.8}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 80.0, 73.0, 70.0, 68.0, 67.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [82.0, 79.0, 70.0, 96.0, 98.0, 105.0, 92.0, 80.0, 79.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [116.0, 119.0, 130.0, 129.0, 116.0, 120.0, 102.0, 124.0, 125.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [135.0, 134.0, 133.0, 133.0, 132.0, 122.0, 133.0, 133.0, 133.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.3}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 66.0, 65.0, 68.0, 65.0, 65.0, 66.0, 67.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1440.8}]} 05:32:52 INFO - Return code: 0 05:32:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:32:52 INFO - # TBPL SUCCESS # 05:32:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:32:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:32:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:32:52 INFO - 2016-04-14 05:32:52.865 screenresolution[1678:9738] starting screenresolution argv=screenresolution get 05:32:52 INFO - 2016-04-14 05:32:52.868 screenresolution[1678:9738] Display 0: 1600x1200x32@60 05:32:52 INFO - 2016-04-14 05:32:52.874 screenresolution[1679:9741] starting screenresolution argv=screenresolution list 05:32:52 INFO - Available Modes on Display 0 05:32:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:32:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:32:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:32:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:32:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:32:53 INFO - Intel Iris: 05:32:53 INFO - Chipset Model: Intel Iris 05:32:53 INFO - Type: GPU 05:32:53 INFO - Bus: Built-In 05:32:53 INFO - VRAM (Dynamic, Max): 1536 MB 05:32:53 INFO - Vendor: Intel (0x8086) 05:32:53 INFO - Device ID: 0x0a2e 05:32:53 INFO - Revision ID: 0x0009 05:32:53 INFO - Displays: 05:32:53 INFO - Display: 05:32:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:32:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:32:53 INFO - Display Serial Number: 1600x1200 60 05:32:53 INFO - Main Display: Yes 05:32:53 INFO - Mirror: Off 05:32:53 INFO - Online: Yes 05:32:53 INFO - Rotation: Supported 05:32:53 INFO - Return code: 0 05:32:53 INFO - Running post-action listener: _resource_record_post_action 05:32:53 INFO - Running post-run listener: _resource_record_post_run 05:32:54 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 37766656; Write bytes: 666072576; Read time: 399; Write time: 1948 05:32:54 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 358519296; Write bytes: 354362880; Read time: 27899; Write time: 701 05:32:54 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 35902976; Write bytes: 300535808; Read time: 376; Write time: 1218 05:32:54 INFO - Running post-run listener: _upload_blobber_files 05:32:54 INFO - Blob upload gear active. 05:32:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:32:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:32:54 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'] 05:32:54 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 05:32:54 INFO - (blobuploader) - INFO - Open directory for files ... 05:32:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:32:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:32:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:55 INFO - (blobuploader) - INFO - Done attempting. 05:32:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:32:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:32:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:56 INFO - (blobuploader) - INFO - Done attempting. 05:32:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:32:56 INFO - Return code: 0 05:32:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:32:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:32:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed83500880e316164e1f2fbd0685eeb6f202926e5c7a635d7c6cde5bc784176b787722c18883a9557f4c6e0ebb22bd445e0c11d3963619b9a4e9dff5ec844382", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/416144ea3658fa526c7ffd5471f26af0f3dea47e1a5f8a0f7a86cde2d89da8aa0187c71f11c9d0a20fab37a36b8574704d088cc2aa07c2002a0f031179f7b6ad"} 05:32:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:32:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:32:56 INFO - Contents: 05:32:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed83500880e316164e1f2fbd0685eeb6f202926e5c7a635d7c6cde5bc784176b787722c18883a9557f4c6e0ebb22bd445e0c11d3963619b9a4e9dff5ec844382", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/416144ea3658fa526c7ffd5471f26af0f3dea47e1a5f8a0f7a86cde2d89da8aa0187c71f11c9d0a20fab37a36b8574704d088cc2aa07c2002a0f031179f7b6ad"} 05:32:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:32:56 INFO - Copying logs to upload dir... 05:32:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:32:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.750362 ========= master_lag: 2.81 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-14 05:32:59.708349) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 05:32:59.712248) ========= 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.dj60VucSxa/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.yiZMIx5GwJ/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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/ed83500880e316164e1f2fbd0685eeb6f202926e5c7a635d7c6cde5bc784176b787722c18883a9557f4c6e0ebb22bd445e0c11d3963619b9a4e9dff5ec844382", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/416144ea3658fa526c7ffd5471f26af0f3dea47e1a5f8a0f7a86cde2d89da8aa0187c71f11c9d0a20fab37a36b8574704d088cc2aa07c2002a0f031179f7b6ad"} build_url:https://queue.taskcluster.net/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011069 build_url: 'https://queue.taskcluster.net/v1/task/N39msMiLT52RrOo44E07rQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed83500880e316164e1f2fbd0685eeb6f202926e5c7a635d7c6cde5bc784176b787722c18883a9557f4c6e0ebb22bd445e0c11d3963619b9a4e9dff5ec844382", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/416144ea3658fa526c7ffd5471f26af0f3dea47e1a5f8a0f7a86cde2d89da8aa0187c71f11c9d0a20fab37a36b8574704d088cc2aa07c2002a0f031179f7b6ad"}' ========= master_lag: 0.33 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 05:33:00.050825) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:33:00.051230) ========= 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.dj60VucSxa/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.yiZMIx5GwJ/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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.005835 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:33:00.116742) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 05:33:00.117159) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 05:33:00.117842) ========= ========= Total master_lag: 6.04 =========