builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0066 starttime: 1462553718.28 results: success (0) buildid: 20160506063418 builduid: 101946d3d6c1492cb9298cdbcff7f8e9 revision: f485ca11d5d597330094223dd9cc9dfa035f7ab3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 09:55:18.282672) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 09:55:18.283095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 09:55:18.283360) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 09:55:18.301460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:55:18.301804) ========= 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.85hCtLq3aP/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.lw0wKq31Ld/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-06 09:55:18-- 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% 150M=0s 2016-05-06 09:55:18 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114465 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:55:18.433158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:55:18.433458) ========= 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.85hCtLq3aP/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.lw0wKq31Ld/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.021705 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:55:18.482165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-06 09:55:18.482483) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f485ca11d5d597330094223dd9cc9dfa035f7ab3 --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-beta --rev f485ca11d5d597330094223dd9cc9dfa035f7ab3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.85hCtLq3aP/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.lw0wKq31Ld/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-06 09:55:18,553 truncating revision to first 12 chars 2016-05-06 09:55:18,553 Setting DEBUG logging. 2016-05-06 09:55:18,553 attempt 1/10 2016-05-06 09:55:18,553 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f485ca11d5d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 09:55:20,312 unpacking tar archive at: mozilla-beta-f485ca11d5d5/testing/mozharness/ program finished with exit code 0 elapsedTime=2.009699 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-06 09:55:20.509262) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 09:55:20.509639) ========= script_repo_revision: f485ca11d5d597330094223dd9cc9dfa035f7ab3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 09:55:20.510016) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 09:55:20.510274) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 09:55:20.523232) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-06 09:55:20.523492) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.85hCtLq3aP/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.lw0wKq31Ld/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 09:55:20 INFO - MultiFileLogger online at 20160506 09:55:20 in /builds/slave/test 09:55:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:55:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:55:20 INFO - {'append_to_log': False, 09:55:20 INFO - 'base_work_dir': '/builds/slave/test', 09:55:20 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:55:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:55:20 INFO - 'branch': 'Mozilla-Beta', 09:55:20 INFO - 'buildbot_json_path': 'buildprops.json', 09:55:20 INFO - 'config_files': ('talos/mac_config.py',), 09:55:20 INFO - 'default_actions': ('clobber', 09:55:20 INFO - 'read-buildbot-config', 09:55:20 INFO - 'download-and-extract', 09:55:20 INFO - 'populate-webroot', 09:55:20 INFO - 'create-virtualenv', 09:55:20 INFO - 'install', 09:55:20 INFO - 'run-tests'), 09:55:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:55:20 INFO - 'download_minidump_stackwalk': True, 09:55:20 INFO - 'download_symbols': 'ondemand', 09:55:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:55:20 INFO - 'tooltool.py': '/tools/tooltool.py', 09:55:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:55:20 INFO - '/tools/misc-python/virtualenv.py')}, 09:55:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:55:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:55:20 INFO - 'installer_path': 'installer.exe', 09:55:20 INFO - 'log_level': 'info', 09:55:20 INFO - 'log_name': 'talos', 09:55:20 INFO - 'log_to_console': True, 09:55:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:55:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:55:20 INFO - 'opt_config_files': (), 09:55:20 INFO - 'pip_index': False, 09:55:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:55:20 INFO - 'cmd': ('bash', 09:55:20 INFO - '-c', 09:55:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:55:20 INFO - 'enabled': True, 09:55:20 INFO - 'halt_on_failure': False, 09:55:20 INFO - 'name': 'check_screen_resolution'},), 09:55:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:55:20 INFO - 'cmd': ('bash', 09:55:20 INFO - '-c', 09:55:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:55:20 INFO - 'enabled': True, 09:55:20 INFO - 'halt_on_failure': False, 09:55:20 INFO - 'name': 'check_screen_resolution'},), 09:55:20 INFO - 'run_cmd_checks_enabled': True, 09:55:20 INFO - 'sps_profile': False, 09:55:20 INFO - 'sps_profile_interval': 0, 09:55:20 INFO - 'suite': 'dromaeojs', 09:55:20 INFO - 'system_bits': '32', 09:55:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:55:20 INFO - 'title': 't-yosemite-r7-0066', 09:55:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:55:20 INFO - 'use_talos_json': True, 09:55:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:55:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:55:20 INFO - 'work_dir': 'build'} 09:55:20 INFO - ##### 09:55:20 INFO - ##### Running clobber step. 09:55:20 INFO - ##### 09:55:20 INFO - Running pre-action listener: _resource_record_pre_action 09:55:20 INFO - Running main action method: clobber 09:55:20 INFO - rmtree: /builds/slave/test/build 09:55:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:55:21 INFO - Running post-action listener: _resource_record_post_action 09:55:21 INFO - ##### 09:55:21 INFO - ##### Running read-buildbot-config step. 09:55:21 INFO - ##### 09:55:21 INFO - Running pre-action listener: _resource_record_pre_action 09:55:21 INFO - Running main action method: read_buildbot_config 09:55:21 INFO - Using buildbot properties: 09:55:21 INFO - { 09:55:21 INFO - "project": "", 09:55:21 INFO - "product": "firefox", 09:55:21 INFO - "script_repo_revision": "production", 09:55:21 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:55:21 INFO - "repository": "", 09:55:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:55:21 INFO - "buildid": "20160506063418", 09:55:21 INFO - "pgo_build": "False", 09:55:21 INFO - "basedir": "/builds/slave/test", 09:55:21 INFO - "buildnumber": 1, 09:55:21 INFO - "slavename": "t-yosemite-r7-0066", 09:55:21 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:55:21 INFO - "platform": "yosemite_r7", 09:55:21 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:55:21 INFO - "branch": "mozilla-beta", 09:55:21 INFO - "repo_path": "releases/mozilla-beta", 09:55:21 INFO - "revision": "f485ca11d5d597330094223dd9cc9dfa035f7ab3", 09:55:21 INFO - "stage_platform": "macosx64", 09:55:21 INFO - "builduid": "101946d3d6c1492cb9298cdbcff7f8e9", 09:55:21 INFO - "slavebuilddir": "test" 09:55:21 INFO - } 09:55:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 09:55:21 INFO - Running post-action listener: _resource_record_post_action 09:55:21 INFO - ##### 09:55:21 INFO - ##### Running download-and-extract step. 09:55:21 INFO - ##### 09:55:21 INFO - Running pre-action listener: _resource_record_pre_action 09:55:21 INFO - Running main action method: download_and_extract 09:55:21 INFO - mkdir: /builds/slave/test/build/tests 09:55: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')]} 09:55:21 INFO - https://queue.taskcluster.net/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:55:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 09:55:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 09:55:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 09:55:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 09:55:23 INFO - Downloaded 1241 bytes. 09:55:23 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 09:55:23 INFO - Using the following test package requirements: 09:55:23 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 09:55:23 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:55:23 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 09:55:23 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:55:23 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 09:55:23 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:55:23 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:55:23 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 09:55:23 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 09:55:23 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:55:23 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 09:55:23 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:55:23 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 09:55:23 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:55:23 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 09:55:23 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 09:55:23 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:55:23 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 09:55:23 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 09:55:23 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')]} 09:55:23 INFO - https://queue.taskcluster.net/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:55:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:55:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:55:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 09:55:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 09:55:24 INFO - Downloaded 17747494 bytes. 09:55:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:55:27 INFO - Return code: 0 09:55:27 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:55:27 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')]} 09:55:27 INFO - https://queue.taskcluster.net/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:55:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:55:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:55:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 09:55:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 09:55:28 INFO - Downloaded 17747494 bytes. 09:55:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:55:32 INFO - Return code: 0 09:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:32 INFO - https://queue.taskcluster.net/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:55:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 09:55:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 09:55:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 09:55:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 09:55:33 INFO - Downloaded 10845194 bytes. 09:55:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:55:33 INFO - Return code: 0 09:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:33 INFO - https://queue.taskcluster.net/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 09:55:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:55:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:55:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 09:55:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 09:55:35 INFO - Downloaded 88340745 bytes. 09:55:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:55:35 INFO - mkdir: /builds/slave/test/properties 09:55:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:55:35 INFO - Writing to file /builds/slave/test/properties/build_url 09:55:35 INFO - Contents: 09:55:35 INFO - build_url:https://queue.taskcluster.net/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:55:37 INFO - Running post-action listener: _resource_record_post_action 09:55:37 INFO - Running post-action listener: set_extra_try_arguments 09:55:37 INFO - ##### 09:55:37 INFO - ##### Running populate-webroot step. 09:55:37 INFO - ##### 09:55:37 INFO - Running pre-action listener: _resource_record_pre_action 09:55:37 INFO - Running main action method: populate_webroot 09:55:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:55:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:55:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:55:37 INFO - '--tppagecycles', 09:55:37 INFO - '7'], 09:55:37 INFO - 'tests': ['tsvgm']}}, 09:55:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:55:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:55:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:55:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:55:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:55:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:55:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:37 INFO - 'talos_options': ['--e10s'], 09:55:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:37 INFO - 'tests': ['damp', 'tps']}, 09:55:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:37 INFO - 'talos_options': ['--e10s'], 09:55:37 INFO - 'tests': ['damp', 'tps']}, 09:55:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:55:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:55:37 INFO - 'other': {'tests': ['a11yr', 09:55:37 INFO - 'ts_paint', 09:55:37 INFO - 'tpaint', 09:55:37 INFO - 'sessionrestore', 09:55:37 INFO - 'sessionrestore_no_auto_restore', 09:55:37 INFO - 'tabpaint']}, 09:55:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:55:37 INFO - 'tests': ['a11yr', 09:55:37 INFO - 'ts_paint', 09:55:37 INFO - 'tpaint', 09:55:37 INFO - 'sessionrestore', 09:55:37 INFO - 'sessionrestore_no_auto_restore', 09:55:37 INFO - 'tabpaint']}, 09:55:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:55:37 INFO - 'tests': ['a11yr', 09:55:37 INFO - 'ts_paint', 09:55:37 INFO - 'tpaint', 09:55:37 INFO - 'sessionrestore', 09:55:37 INFO - 'sessionrestore_no_auto_restore', 09:55:37 INFO - 'tabpaint']}, 09:55:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:55:37 INFO - 'tests': ['a11yr', 09:55:37 INFO - 'ts_paint', 09:55:37 INFO - 'tpaint', 09:55:37 INFO - 'sessionrestore', 09:55:37 INFO - 'sessionrestore_no_auto_restore', 09:55:37 INFO - 'tabpaint']}, 09:55:37 INFO - 'other_l64': {'tests': ['a11yr', 09:55:37 INFO - 'ts_paint', 09:55:37 INFO - 'tpaint', 09:55:37 INFO - 'sessionrestore', 09:55:37 INFO - 'sessionrestore_no_auto_restore', 09:55:37 INFO - 'tabpaint']}, 09:55:37 INFO - 'other_nol64': {'tests': ['a11yr', 09:55:37 INFO - 'ts_paint', 09:55:37 INFO - 'tpaint', 09:55:37 INFO - 'sessionrestore', 09:55:37 INFO - 'sessionrestore_no_auto_restore', 09:55:37 INFO - 'tabpaint']}, 09:55:37 INFO - 'svgr': {'tests': ['tsvgx', 09:55:37 INFO - 'tsvgr_opacity', 09:55:37 INFO - 'tart', 09:55:37 INFO - 'tscrollx', 09:55:37 INFO - 'cart']}, 09:55:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:55:37 INFO - 'tests': ['tsvgx', 09:55:37 INFO - 'tsvgr_opacity', 09:55:37 INFO - 'tart', 09:55:37 INFO - 'tscrollx', 09:55:37 INFO - 'cart']}, 09:55:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:37 INFO - 'tests': ['tp5o']}, 09:55:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:37 INFO - 'talos_options': ['--e10s'], 09:55:37 INFO - 'tests': ['tp5o']}, 09:55:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:37 INFO - 'talos_options': ['--xperf_path', 09:55:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:37 INFO - 'tests': ['tp5n']}, 09:55:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:37 INFO - 'talos_options': ['--e10s', 09:55:37 INFO - '--xperf_path', 09:55:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:37 INFO - 'tests': ['tp5n']}}, 09:55:37 INFO - 'talos.zip': {'path': '', 09:55:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:55:37 INFO - Running post-action listener: _resource_record_post_action 09:55:37 INFO - ##### 09:55:37 INFO - ##### Running create-virtualenv step. 09:55:37 INFO - ##### 09:55:37 INFO - Running pre-action listener: _resource_record_pre_action 09:55:37 INFO - Running main action method: create_virtualenv 09:55:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:55:37 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 09:55:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:55:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:55:37 INFO - Using real prefix '/tools/python27' 09:55:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:55:37 INFO - Installing distribute.............................................................................................................................................................................................done. 09:55:40 INFO - Installing pip.................done. 09:55:40 INFO - Return code: 0 09:55:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:55:40 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')]} 09:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:40 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')]} 09:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:40 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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c9daaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c408d30>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3ffb20>, '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.85hCtLq3aP/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.lw0wKq31Ld/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 09:55:40 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 09:55:40 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 09:55:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85hCtLq3aP/Render', 09:55:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:40 INFO - 'HOME': '/Users/cltbld', 09:55:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:40 INFO - 'LOGNAME': 'cltbld', 09:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:40 INFO - 'MOZ_NO_REMOTE': '1', 09:55:40 INFO - 'NO_EM_RESTART': '1', 09:55:40 INFO - 'PAGER': '/bin/cat', 09:55:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:40 INFO - 'PWD': '/builds/slave/test', 09:55:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:40 INFO - 'SHELL': '/bin/bash', 09:55:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lw0wKq31Ld/Listeners', 09:55:40 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 09:55:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:40 INFO - 'USER': 'cltbld', 09:55:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:40 INFO - 'XPC_FLAGS': '0x0', 09:55:40 INFO - 'XPC_SERVICE_NAME': '0', 09:55:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:41 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 09:55:41 INFO - Cleaning up... 09:55:41 INFO - Return code: 0 09:55:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:41 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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c9daaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c408d30>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3ffb20>, '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.85hCtLq3aP/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.lw0wKq31Ld/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 09:55:41 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 09:55:41 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 09:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85hCtLq3aP/Render', 09:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:41 INFO - 'HOME': '/Users/cltbld', 09:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:41 INFO - 'LOGNAME': 'cltbld', 09:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:41 INFO - 'MOZ_NO_REMOTE': '1', 09:55:41 INFO - 'NO_EM_RESTART': '1', 09:55:41 INFO - 'PAGER': '/bin/cat', 09:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:41 INFO - 'PWD': '/builds/slave/test', 09:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:41 INFO - 'SHELL': '/bin/bash', 09:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lw0wKq31Ld/Listeners', 09:55:41 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 09:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:41 INFO - 'USER': 'cltbld', 09:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:41 INFO - 'XPC_FLAGS': '0x0', 09:55:41 INFO - 'XPC_SERVICE_NAME': '0', 09:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:41 INFO - Downloading/unpacking psutil>=0.7.1 09:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:55:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:55:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:55:44 INFO - Installing collected packages: psutil 09:55:44 INFO - Running setup.py install for psutil 09:55:44 INFO - building 'psutil._psutil_osx' extension 09:55:44 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 09:55:44 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 09:55:44 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 09:55:44 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 09:55:44 INFO - building 'psutil._psutil_posix' extension 09:55:44 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 09:55:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:55:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:55:44 INFO - ^ 09:55:44 INFO - 1 warning generated. 09:55:44 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 09:55:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:55:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:55:45 INFO - Successfully installed psutil 09:55:45 INFO - Cleaning up... 09:55:45 INFO - Return code: 0 09:55:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:45 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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c9daaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c408d30>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3ffb20>, '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.85hCtLq3aP/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.lw0wKq31Ld/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 09:55:45 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 09:55:45 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 09:55:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85hCtLq3aP/Render', 09:55:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:45 INFO - 'HOME': '/Users/cltbld', 09:55:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:45 INFO - 'LOGNAME': 'cltbld', 09:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:45 INFO - 'MOZ_NO_REMOTE': '1', 09:55:45 INFO - 'NO_EM_RESTART': '1', 09:55:45 INFO - 'PAGER': '/bin/cat', 09:55:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:45 INFO - 'PWD': '/builds/slave/test', 09:55:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:45 INFO - 'SHELL': '/bin/bash', 09:55:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lw0wKq31Ld/Listeners', 09:55:45 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 09:55:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:45 INFO - 'USER': 'cltbld', 09:55:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:45 INFO - 'XPC_FLAGS': '0x0', 09:55:45 INFO - 'XPC_SERVICE_NAME': '0', 09:55:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:55:45 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 09:55:45 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 09:55:45 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 09:55:45 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 09:55:45 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 09:55:45 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 09:55:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:55:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:55:47 INFO - Installing collected packages: mozsystemmonitor 09:55:47 INFO - Running setup.py install for mozsystemmonitor 09:55:48 INFO - Successfully installed mozsystemmonitor 09:55:48 INFO - Cleaning up... 09:55:48 INFO - Return code: 0 09:55:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:55:48 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')]} 09:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:48 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')]} 09:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:48 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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c9daaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c408d30>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3ffb20>, '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.85hCtLq3aP/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.lw0wKq31Ld/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 09:55:48 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 09:55:48 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 09:55:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85hCtLq3aP/Render', 09:55:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:48 INFO - 'HOME': '/Users/cltbld', 09:55:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:48 INFO - 'LOGNAME': 'cltbld', 09:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:48 INFO - 'MOZ_NO_REMOTE': '1', 09:55:48 INFO - 'NO_EM_RESTART': '1', 09:55:48 INFO - 'PAGER': '/bin/cat', 09:55:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:48 INFO - 'PWD': '/builds/slave/test', 09:55:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:48 INFO - 'SHELL': '/bin/bash', 09:55:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lw0wKq31Ld/Listeners', 09:55:48 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 09:55:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:48 INFO - 'USER': 'cltbld', 09:55:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:48 INFO - 'XPC_FLAGS': '0x0', 09:55:48 INFO - 'XPC_SERVICE_NAME': '0', 09:55:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:48 INFO - Downloading/unpacking blobuploader==1.2.4 09:55:48 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 09:55:48 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 09:55:48 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 09:55:48 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 09:55:48 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 09:55:48 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 09:55:50 INFO - Downloading blobuploader-1.2.4.tar.gz 09:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:55:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:55:50 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 09:55:50 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 09:55:50 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 09:55:50 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 09:55:50 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 09:55:50 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 09:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:55:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:55:51 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 09:55:51 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 09:55:51 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 09:55:51 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 09:55:51 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 09:55:51 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 09:55:52 INFO - Downloading docopt-0.6.1.tar.gz 09:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:55:52 INFO - Installing collected packages: blobuploader, requests, docopt 09:55:52 INFO - Running setup.py install for blobuploader 09:55:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:55:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:55:52 INFO - Running setup.py install for requests 09:55:52 INFO - Running setup.py install for docopt 09:55:52 INFO - Successfully installed blobuploader requests docopt 09:55:52 INFO - Cleaning up... 09:55:52 INFO - Return code: 0 09:55:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:52 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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c9daaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c408d30>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3ffb20>, '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.85hCtLq3aP/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.lw0wKq31Ld/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 09:55:52 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 09:55:52 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 09:55:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85hCtLq3aP/Render', 09:55:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:52 INFO - 'HOME': '/Users/cltbld', 09:55:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:52 INFO - 'LOGNAME': 'cltbld', 09:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:52 INFO - 'MOZ_NO_REMOTE': '1', 09:55:52 INFO - 'NO_EM_RESTART': '1', 09:55:52 INFO - 'PAGER': '/bin/cat', 09:55:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:52 INFO - 'PWD': '/builds/slave/test', 09:55:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:52 INFO - 'SHELL': '/bin/bash', 09:55:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lw0wKq31Ld/Listeners', 09:55:52 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 09:55:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:52 INFO - 'USER': 'cltbld', 09:55:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:52 INFO - 'XPC_FLAGS': '0x0', 09:55:52 INFO - 'XPC_SERVICE_NAME': '0', 09:55:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:55:53 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-oQi05T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:55:53 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-kar_Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:55:53 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-8fZbsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:55:53 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-if7Ukn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:55:53 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-cXUQIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:55:53 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-uztSe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:55:53 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-1ab03B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:55:53 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-mKB0kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:55:54 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-m9Teep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:55:54 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Df4bpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:55:54 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-f0h5Iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:55:54 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-sA0F21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:55:54 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-PmVju9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:55:54 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-_lOkwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:54 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-qQMSkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:55:54 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Ed83hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:55:54 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-KZpUFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:55:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:55:54 INFO - Running setup.py install for manifestparser 09:55:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:55:55 INFO - Running setup.py install for mozcrash 09:55:55 INFO - Running setup.py install for mozdebug 09:55:55 INFO - Running setup.py install for mozdevice 09:55:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:55:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:55:55 INFO - Running setup.py install for mozfile 09:55:55 INFO - Running setup.py install for mozhttpd 09:55:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:55:55 INFO - Running setup.py install for mozinfo 09:55:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:55:56 INFO - Running setup.py install for mozInstall 09:55:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:55:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:55:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:55:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:55:56 INFO - Running setup.py install for mozleak 09:55:56 INFO - Running setup.py install for mozlog 09:55:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:55:56 INFO - Running setup.py install for moznetwork 09:55:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:55:56 INFO - Running setup.py install for mozprocess 09:55:56 INFO - Running setup.py install for mozprofile 09:55:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:55:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:55:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:55:56 INFO - Running setup.py install for mozrunner 09:55:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:55:57 INFO - Running setup.py install for mozscreenshot 09:55:57 INFO - Running setup.py install for moztest 09:55:57 INFO - Running setup.py install for mozversion 09:55:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:55:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:55:57 INFO - Cleaning up... 09:55:57 INFO - Return code: 0 09:55:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55:57 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')]} 09:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:57 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')]} 09:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:57 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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c9daaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c408d30>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3ffb20>, '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.85hCtLq3aP/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.lw0wKq31Ld/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 09:55:57 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 09:55:57 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 09:55:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85hCtLq3aP/Render', 09:55:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:57 INFO - 'HOME': '/Users/cltbld', 09:55:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:57 INFO - 'LOGNAME': 'cltbld', 09:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:57 INFO - 'MOZ_NO_REMOTE': '1', 09:55:57 INFO - 'NO_EM_RESTART': '1', 09:55:57 INFO - 'PAGER': '/bin/cat', 09:55:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:57 INFO - 'PWD': '/builds/slave/test', 09:55:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:57 INFO - 'SHELL': '/bin/bash', 09:55:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lw0wKq31Ld/Listeners', 09:55:57 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 09:55:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:57 INFO - 'USER': 'cltbld', 09:55:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:57 INFO - 'XPC_FLAGS': '0x0', 09:55:57 INFO - 'XPC_SERVICE_NAME': '0', 09:55:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:55:57 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-RuSud5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:55:57 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)) 09:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:55:57 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-__XGBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:55:58 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)) 09:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:55:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-eRGBZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:55:58 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)) 09:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:55:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-oiZzVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:55:58 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)) 09:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:55:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-bX_dtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:55:58 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)) 09:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:55:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-iQ_Cua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:55:58 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)) 09:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:55:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-wUUsLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:55:58 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)) 09:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:55:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-dSY7LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:55:58 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)) 09:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:55:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Oh5nD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:55:58 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)) 09:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:55:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-PZIYrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:55:58 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)) 09:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:55:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-DbI7s_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:55:59 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)) 09:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:55:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-OA7mR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:55:59 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)) 09:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:55:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-sDn5WG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:55:59 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)) 09:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:55:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-y8NZMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:55:59 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)) 09:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-tY9Yzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:59 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)) 09:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:55:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Jz0z3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:55:59 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)) 09:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:55:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-8QfmJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:55:59 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)) 09:55:59 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)) 09:55:59 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)) 09:55:59 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)) 09:55:59 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)) 09:55:59 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)) 09:55:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:02 INFO - Downloading blessings-1.6.tar.gz 09:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:56:02 INFO - Installing collected packages: blessings 09:56:02 INFO - Running setup.py install for blessings 09:56:02 INFO - Successfully installed blessings 09:56:02 INFO - Cleaning up... 09:56:02 INFO - Return code: 0 09:56:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:02 INFO - Reading from file tmpfile_stdout 09:56:02 INFO - Current package versions: 09:56:02 INFO - blessings == 1.6 09:56:02 INFO - blobuploader == 1.2.4 09:56:02 INFO - docopt == 0.6.1 09:56:02 INFO - manifestparser == 1.1 09:56:02 INFO - mozInstall == 1.12 09:56:02 INFO - mozcrash == 0.17 09:56:02 INFO - mozdebug == 0.1 09:56:02 INFO - mozdevice == 0.48 09:56:02 INFO - mozfile == 1.2 09:56:02 INFO - mozhttpd == 0.7 09:56:02 INFO - mozinfo == 0.9 09:56:02 INFO - mozleak == 0.1 09:56:02 INFO - mozlog == 3.1 09:56:02 INFO - moznetwork == 0.27 09:56:02 INFO - mozprocess == 0.22 09:56:02 INFO - mozprofile == 0.28 09:56:02 INFO - mozrunner == 6.11 09:56:02 INFO - mozscreenshot == 0.1 09:56:02 INFO - mozsystemmonitor == 0.0 09:56:02 INFO - moztest == 0.7 09:56:02 INFO - mozversion == 1.4 09:56:02 INFO - psutil == 3.1.1 09:56:02 INFO - requests == 1.2.3 09:56:02 INFO - wsgiref == 0.1.2 09:56:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:02 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')]} 09:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:02 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')]} 09:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:02 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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c9daaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c408d30>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3ffb20>, '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.85hCtLq3aP/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.lw0wKq31Ld/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 09:56:02 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 09:56:02 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 09:56:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85hCtLq3aP/Render', 09:56:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:02 INFO - 'HOME': '/Users/cltbld', 09:56:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:02 INFO - 'LOGNAME': 'cltbld', 09:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:02 INFO - 'MOZ_NO_REMOTE': '1', 09:56:02 INFO - 'NO_EM_RESTART': '1', 09:56:02 INFO - 'PAGER': '/bin/cat', 09:56:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:02 INFO - 'PWD': '/builds/slave/test', 09:56:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:02 INFO - 'SHELL': '/bin/bash', 09:56:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lw0wKq31Ld/Listeners', 09:56:02 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 09:56:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:02 INFO - 'USER': 'cltbld', 09:56:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:02 INFO - 'XPC_FLAGS': '0x0', 09:56:02 INFO - 'XPC_SERVICE_NAME': '0', 09:56:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:02 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)) 09:56:02 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)) 09:56:02 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)) 09:56:02 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)) 09:56:02 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)) 09:56:02 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)) 09:56:02 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)) 09:56:02 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)) 09:56:02 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)) 09:56:02 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)) 09:56:02 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)) 09:56:02 INFO - Cleaning up... 09:56:02 INFO - Return code: 0 09:56:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:56:02 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')]} 09:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:02 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')]} 09:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:02 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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c9daaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c408d30>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3ffb20>, '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.85hCtLq3aP/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.lw0wKq31Ld/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 09:56:02 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 09:56:02 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 09:56:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85hCtLq3aP/Render', 09:56:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:02 INFO - 'HOME': '/Users/cltbld', 09:56:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:02 INFO - 'LOGNAME': 'cltbld', 09:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:02 INFO - 'MOZ_NO_REMOTE': '1', 09:56:02 INFO - 'NO_EM_RESTART': '1', 09:56:02 INFO - 'PAGER': '/bin/cat', 09:56:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:02 INFO - 'PWD': '/builds/slave/test', 09:56:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:02 INFO - 'SHELL': '/bin/bash', 09:56:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lw0wKq31Ld/Listeners', 09:56:02 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 09:56:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:02 INFO - 'USER': 'cltbld', 09:56:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:02 INFO - 'XPC_FLAGS': '0x0', 09:56:02 INFO - 'XPC_SERVICE_NAME': '0', 09:56:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:03 INFO - Downloading/unpacking jsonschema 09:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:56:05 INFO - Downloading/unpacking functools32 (from jsonschema) 09:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:05 INFO - Downloading functools32-3.2.3-2.tar.gz 09:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:56:06 INFO - warning: no files found matching '*.txt' 09:56:06 INFO - no previously-included directories found matching 'build' 09:56:06 INFO - no previously-included directories found matching 'dist' 09:56:06 INFO - no previously-included directories found matching '.git*' 09:56:06 INFO - Installing collected packages: jsonschema, functools32 09:56:06 INFO - Running setup.py install for functools32 09:56:06 INFO - warning: no files found matching '*.txt' 09:56:06 INFO - no previously-included directories found matching 'build' 09:56:06 INFO - no previously-included directories found matching 'dist' 09:56:06 INFO - no previously-included directories found matching '.git*' 09:56:06 INFO - Successfully installed jsonschema functools32 09:56:06 INFO - Cleaning up... 09:56:06 INFO - Return code: 0 09:56:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:56: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')]} 09:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56: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')]} 09:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c9daaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c408d30>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3ffb20>, '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.85hCtLq3aP/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.lw0wKq31Ld/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 09:56:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:56:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85hCtLq3aP/Render', 09:56:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:06 INFO - 'HOME': '/Users/cltbld', 09:56:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:06 INFO - 'LOGNAME': 'cltbld', 09:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:06 INFO - 'MOZ_NO_REMOTE': '1', 09:56:06 INFO - 'NO_EM_RESTART': '1', 09:56:06 INFO - 'PAGER': '/bin/cat', 09:56:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:06 INFO - 'PWD': '/builds/slave/test', 09:56:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:06 INFO - 'SHELL': '/bin/bash', 09:56:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lw0wKq31Ld/Listeners', 09:56:06 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 09:56:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:06 INFO - 'USER': 'cltbld', 09:56:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:06 INFO - 'XPC_FLAGS': '0x0', 09:56:06 INFO - 'XPC_SERVICE_NAME': '0', 09:56:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:06 INFO - Downloading/unpacking flake8 09:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:56:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:56:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:56:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:56:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:56:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:56:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:56:10 INFO - no previously-included directories found matching 'docs/_build' 09:56:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:56:10 INFO - Running setup.py install for pep8 09:56:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:56:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:56:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:56:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:56:10 INFO - no previously-included directories found matching 'docs/_build' 09:56:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:56:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:56:10 INFO - Cleaning up... 09:56:10 INFO - Return code: 0 09:56:10 INFO - Running post-action listener: _resource_record_post_action 09:56:10 INFO - Running post-action listener: _start_resource_monitoring 09:56:10 INFO - Starting resource monitoring. 09:56:10 INFO - ##### 09:56:10 INFO - ##### Running install step. 09:56:10 INFO - ##### 09:56:10 INFO - Running pre-action listener: _resource_record_pre_action 09:56:10 INFO - Running main action method: install 09:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:10 INFO - Reading from file tmpfile_stdout 09:56:10 INFO - Detecting whether we're running mozinstall >=1.0... 09:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:56:11 INFO - Reading from file tmpfile_stdout 09:56:11 INFO - Output received: 09:56:11 INFO - Usage: mozinstall [options] installer 09:56:11 INFO - Options: 09:56:11 INFO - -h, --help show this help message and exit 09:56:11 INFO - -d DEST, --destination=DEST 09:56:11 INFO - Directory to install application into. [default: 09:56:11 INFO - "/builds/slave/test"] 09:56:11 INFO - --app=APP Application being installed. [default: firefox] 09:56:11 INFO - mkdir: /builds/slave/test/build/application 09:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:56:33 INFO - Reading from file tmpfile_stdout 09:56:33 INFO - Output received: 09:56:33 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:56:33 INFO - Running post-action listener: _resource_record_post_action 09:56:33 INFO - ##### 09:56:33 INFO - ##### Running run-tests step. 09:56:33 INFO - ##### 09:56:33 INFO - Running pre-action listener: _resource_record_pre_action 09:56:33 INFO - Running main action method: run_tests 09:56:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:56:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:56:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:56:33 INFO - 2016-05-06 09:56:33.851 screenresolution[2494:21375] starting screenresolution argv=screenresolution get 09:56:33 INFO - 2016-05-06 09:56:33.854 screenresolution[2494:21375] Display 0: 1600x1200x32@60 09:56:33 INFO - 2016-05-06 09:56:33.860 screenresolution[2495:21379] starting screenresolution argv=screenresolution list 09:56:33 INFO - Available Modes on Display 0 09:56:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:56:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:56:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:56:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:56:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:56:34 INFO - Intel Iris: 09:56:34 INFO - Chipset Model: Intel Iris 09:56:34 INFO - Type: GPU 09:56:34 INFO - Bus: Built-In 09:56:34 INFO - VRAM (Dynamic, Max): 1536 MB 09:56:34 INFO - Vendor: Intel (0x8086) 09:56:34 INFO - Device ID: 0x0a2e 09:56:34 INFO - Revision ID: 0x0009 09:56:34 INFO - Displays: 09:56:34 INFO - Display: 09:56:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:56:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:56:34 INFO - Display Serial Number: 1600x1200 60 09:56:34 INFO - Main Display: Yes 09:56:34 INFO - Mirror: Off 09:56:34 INFO - Online: Yes 09:56:34 INFO - Rotation: Supported 09:56:34 INFO - Return code: 0 09:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:56:34 INFO - Python 2.7.3 09:56:34 INFO - Return code: 0 09:56:34 INFO - grabbing minidump binary from tooltool 09:56: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')]} 09:56:34 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 0x10c408d30>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3ffb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:56:34 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 09:56:34 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 09:56:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:56:34 INFO - Return code: 0 09:56:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:56:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:56:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:56:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:56:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:56:35 INFO - Return code: 0 09:56:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 09:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0066 --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 09:56:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85hCtLq3aP/Render', 09:56:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:35 INFO - 'HOME': '/Users/cltbld', 09:56:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:35 INFO - 'LOGNAME': 'cltbld', 09:56:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:56:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:35 INFO - 'MOZ_NO_REMOTE': '1', 09:56:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:56:35 INFO - 'NO_EM_RESTART': '1', 09:56:35 INFO - 'PAGER': '/bin/cat', 09:56:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:35 INFO - 'PWD': '/builds/slave/test', 09:56:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:56:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:35 INFO - 'SHELL': '/bin/bash', 09:56:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lw0wKq31Ld/Listeners', 09:56:35 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 09:56:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:35 INFO - 'USER': 'cltbld', 09:56:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:35 INFO - 'XPC_FLAGS': '0x0', 09:56:35 INFO - 'XPC_SERVICE_NAME': '0', 09:56:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 09:56:35 INFO - mozversion application_buildid: 20160506063418 09:56:35 INFO - mozversion application_changeset: f485ca11d5d597330094223dd9cc9dfa035f7ab3 09:56:35 INFO - mozversion application_display_name: Firefox 09:56:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:56:35 INFO - mozversion application_name: Firefox 09:56:35 INFO - mozversion application_remotingname: firefox 09:56:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:56:35 INFO - mozversion application_vendor: Mozilla 09:56:35 INFO - mozversion application_version: 47.0 09:56:35 INFO - mozversion platform_buildid: 20160506063418 09:56:35 INFO - mozversion platform_changeset: f485ca11d5d597330094223dd9cc9dfa035f7ab3 09:56:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:56:35 INFO - mozversion platform_version: 47.0 09:56:35 INFO - using testdate: 1462553795 09:56:35 INFO - actual date: 1462553795 09:56:35 INFO - starting webserver on 'localhost:53195' 09:56:35 INFO - SUITE-START | Running 2 tests 09:56:35 INFO - TEST-START | dromaeo_css 09:56:35 INFO - operating with platform_type : mac_ 09:56:35 INFO - Initialising browser for dromaeo_css test... 09:56:35 INFO - TEST-INFO | started process 2513 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpBeswar/profile http://localhost:53195/getInfo.html) 09:56:37 INFO - PROCESS | 2513 | __metrics Screen width/height:1600/1200 09:56:37 INFO - PROCESS | 2513 | colorDepth:24 09:56:37 INFO - PROCESS | 2513 | Browser inner width/height: 1024/689 09:56:37 INFO - PROCESS | 2513 | __metrics 09:56:37 INFO - PROCESS | 2513 | 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" 09:56:37 INFO - PROCESS | 2513 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:56:38 INFO - TEST-INFO | 2513: exit 0 09:56:38 INFO - Browser initialized. 09:56:38 INFO - Running cycle 1/1 for dromaeo_css test... 09:56:38 INFO - TEST-INFO | started process 2516 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpBeswar/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:50 INFO - PROCESS | 2516 | RSS: Main: 156696576 09:56:50 INFO - PROCESS | 2516 | 09:57:41 INFO - PROCESS | 2516 | 1462553861056 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] 09:59:50 INFO - PROCESS | 2516 | Cycle 1(1): loaded http://localhost:53195/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53195/tests/dromaeo/cssquery-ext.html) 09:59:52 INFO - PROCESS | 2516 | RSS: Main: 302088192 09:59:52 INFO - PROCESS | 2516 | 10:02:54 INFO - PROCESS | 2516 | Cycle 1(1): loaded http://localhost:53195/tests/dromaeo/cssquery-ext.html (next: http://localhost:53195/tests/dromaeo/cssquery-jquery.html) 10:02:55 INFO - PROCESS | 2516 | RSS: Main: 290308096 10:02:55 INFO - PROCESS | 2516 | 10:05:57 INFO - PROCESS | 2516 | Cycle 1(1): loaded http://localhost:53195/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53195/tests/dromaeo/cssquery-mootools.html) 10:05:57 INFO - PROCESS | 2516 | RSS: Main: 294039552 10:05:57 INFO - PROCESS | 2516 | 10:08:59 INFO - PROCESS | 2516 | Cycle 1(1): loaded http://localhost:53195/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53195/tests/dromaeo/cssquery-prototype.html) 10:09:00 INFO - PROCESS | 2516 | RSS: Main: 253808640 10:09:00 INFO - PROCESS | 2516 | 10:12:03 INFO - PROCESS | 2516 | Cycle 1(1): loaded http://localhost:53195/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53195/tests/dromaeo/cssquery-yui.html) 10:12:04 INFO - PROCESS | 2516 | RSS: Main: 255283200 10:12:04 INFO - PROCESS | 2516 | 10:15:06 INFO - PROCESS | 2516 | Cycle 1(1): loaded http://localhost:53195/tests/dromaeo/cssquery-yui.html (next: http://localhost:53195/tests/dromaeo/cssquery-dojo.html) 10:15:06 INFO - PROCESS | 2516 | RSS: Main: 303706112 10:15:06 INFO - PROCESS | 2516 | 10:15:06 INFO - PROCESS | 2516 | __start_tp_report 10:15:06 INFO - PROCESS | 2516 | _x_x_mozilla_page_load 10:15:06 INFO - PROCESS | 2516 | _x_x_mozilla_page_load_details 10:15:06 INFO - PROCESS | 2516 | |i|pagename|runs| 10:15:06 INFO - PROCESS | 2516 | |0;dojo.html;3537.5754909410866;3608.116011577164;3611.0972256935765;3629.6733294003543;3692.8892133236013;6005.069214271789;6011.939880601192;6040.697965101749;6048.467654932673;6052.42501962314;6057.303410107839;6064.727087281072;6066.939330606692;6071.60534565253;6078.240219972504;5287.973560132194;5382.650127741694;5400.459954004607;5467.535259502947;5499.120140777476;5477.178423236526;5478.91781623276;5480.177973304017;5483;5486.506214440699;5050.368703912011;5400.189971504266;5448.291722076125;5474;5479.068558345071;4462.509123996358;4557.544245575449;4639.907201855944;5506.99999999998;5512.200236665114;5315.627906046579;5336.119540275849;5394.136938089926;5412.5940554458175;5416.485433883775;5345.919811202835;5783;5794.304683438015;5802.535797136219;5835.978703726831;6187;6287;6288.371162883721;6297.779577714804;6317.842053948642;6284.340144284875;6319.399657032621;6320;6350.9682451587905;6380.61716297019;6125.754969801203;6150.108234306001;6160.568760186834;6164.291106522717;6173.32093469718;6356.968215158895;6478.546501744832;6532.248791388956;6534.836629084216;6544.70548825304;6241.375862413723;6271.937280627135;6294.087357333161;6298.992161254269;6300.905486417708;6403.103565500834;6409.423151916257;6412.807615771534;6415.294317625057;6433.517486188554;6193.009118541012;6195.938040619626;6208.906866397007;6291.811245662638;6316.9368306317265;6245.188125543741;6264.029075493306;6290.150829638032;6319.715612797343;6321.778737744157;5133.050385678662;5144.536991670693;5146.459621739664;5146.716930568779;5159.458256883048;4501.3022981437925;4580.496145424001;4596.97701511497;4611.5619016193405;4671.8364857229835;6004.279486461653;6027.939720602738;6034.783475357517;6058.545609079337;6067.24159480065;6252.531060170505;6267.0286105653695;6351.9682401588625;6406.199225096863;6440.162778838721;6016.187814644967;6055.122007308915;6060.757569697251;6084.4828189603495;6089.451949324493;5535.169724541351;5540.86147846299;5545.085060964976;5553.888922221533;5562.360328562187;6386.648734319564;6483.189601299838;6561.179852518435;6583.407493325528;6604.24051234095;6375.075614035846;6390.7443702251385;6419.743210271724;6423.261324947691;6441.871162576816;6432.35676432353;6672.399484046459;6678.732850686112;6693.364130407604;6700.061991321317;6233.2208473940755;6257.624542527463;6315.494760419064;6319.8104056878365;6328.778492752732;6350.206224221973;6359.046143078575;6367.172267605181;6392.0731493934045;6400.103985442135;6095.420935011167;6183.876322473436;6246.562740608114;6249.0626406039455;6255.155554000152;6176.258848938156;6251.187345645037;6261.186045814015;6262.436380725757;6264.937350626617;6148.661823599745;6199.535034872312;6202.72087756043;6209.379062093754;6217.564770466024;6193.81418557444;6199.690015499117;6205.944989351911;6216.564840461125;6264.624122552661;6222.315545290105;6254.906176407449;6261.624302541862;6264.185655864709;6267.529935254783 10:15:06 INFO - PROCESS | 2516 | |1;ext.html;481.29970892351633;532.4017077737153;578.1991941161491;594.3343455330029;672.7712577723573;41865.372019419694;42436.57563424365;42519.14961700764;42553.148937021244;42566.787166064205;45816.85457863555;46219.53780462194;46337;46377.7681111594;46556;9758.316917815739;9950.203983681324;9956.551955161998;9963.15313198379;9963.75090622733;8383.245507904287;10039.941811928573;10046;10070.496475176249;10123.797524049514;10055.446950417723;10147.391156530632;10157.644482443116;10183.338083024617;10213.336133151359;10043.096121349077;10125;10138.493075346203;10139.493025348704;10141.391516508997;9958.402495850272;10058.497075146286;10091.646792362231;10095.899041009643;10103.939086395969;42630.78684606557;43893;44008.559914400765;44514.77742611299;44564.77717611391;3387.728981681484;3464.2551851351827;3472.774269672463;3529.982350088259;3570.928581428383;29197.85401073002;30111.698883011326;30202.395952081057;30250.697493025007;30557.38885222283;2839.4746971810073;2872;2877.6978417266096;2885.5960165576835;2947.8673459694364;510629.12798052264;515097;515645.42177289247;516393;516506;74455.25544744592;74873.50252995019;75333;75395.62302188454;75511.62244188743;79194.60402697949;82337.58831205925;82673.58663206645;82691.58654206811;82815.58592207001;18958.14688339028;19198.94405807666;19220.231190752213;19256.711149332772;19300.613987720448;14624.415023399157;14693.412263509554;14740.262986850614;14748.926255368655;14772.26138693061;18527.166277517543;20186.798132018786;21113.73317600918;21753.69477831335;24131.517369652858;7592.620368981528;7854.8429031419055;9441.622335106518;9535.332526723063;9551.283653726;1024.2267088348249;1110.7945030169444;1123.550579768083;1135.795556799784;1153.9192256542128;30977.380452391277;31525.842370788;31606;31954.84022579872;32303.676963230537;1013.2198207380424;1182.9231099978474;1188.4830098907003;1196.802527582939;1319.6107148391056;11983.28100313984;14064.08583442073;15773.526794196192;16999.23503442348;17046.82953170477;561962;568932;571977;572520;572868;57965.8406831861;63968.36031639624;66010;66233.33766662369;66368;1407.2893188939724;1428.728541577097;1514.6062023873872;1540.8536189062245;1561.2662048837028;26685.86657066702;29864.85067574735;31947.68052319447;32338;32347;53038.73480632572;53407.19889201588;53450;53471.732641336544;53528.73235633797;311873;360876;374329;374750;374755;31061.378772423974;35422.22888855598;35775.82112089423;36296.81851590725;36301;46887.765561171975;47085.529144709486;48247.5175248243;48716.512834871195;49510.75244623754;38365.424518632804;38642.80678596589;39784.60215397925;39811.40282895817;40768.98077548085;38573.61426385812;38978;39315.60684393119;39736;39854.80072599618;38451.42322865215;41313.79343103265;41659;42736.78631606946;42786.14427711366;33550.66449335475;35288.64711352854;35724.10689732777;35853.28293434169;36043.45934811032;26626.201213963614;26665;26699.33251668724;26953.3261668452;27125.72874271232 10:15:06 INFO - PROCESS | 2516 | |2;jquery.html;325.6613122352753;381.68510978442777;382.8564288391854;392.4427313215234;393.26459520696267;20522.38432847015;20547.897260513695;20599.794002059974;21506.677399839016;21530.89234553829;20747;21050.578988420224;21056.473588160305;21075.05162267698;21653.67519487209;5760.107183386572;6080.087986801971;6099.176611157503;6105.725242364104;6132.110843927628;4156.127213285198;4355.107203023373;5683.545316374701;5923.407659234063;6177.876442471171;6129.877402451948;6162.1681073055015;6166.260048794151;6166.907496387557;6174.629522228658;4120.75275483469;6059.484943779762;6528.967355163218;6703.8324041899095;6705.597664140168;4235.98336399265;5642.125470552071;5873.911891321633;5882.411758824126;5899.056151015817;14286.499972500913;14288.857111428857;14311.928440357835;18130.730848840587;25562.87218563914;2115.883626400547;2231.230225572175;2296.311106667993;2425.248173066355;2508.8745562721792;10825.350478971208;11787.941060294643;13392.397342119531;15061.397544098223;15307.31117099722;1645.3829813819818;1743.808181100078;1773.1488885334982;1792.345793785272;1839.3194518028415;111346.44326778395;115414;116995;117427.41286293599;117609.41195293968;9709.980452052432;10381.11760500366;10728.409937453358;10964.28732132409;11685.415729213506;14919.850801491846;14923;14935.178565178801;14945.925270373797;14983.475578354706;9007.63969441228;9086.591103400362;9089.727308180765;9175.632974680939;9206.493642849708;9175.44947303164;9202.355835091614;9259.768505787275;9280.489573073412;9309.115634014757;3728.8694895678523;4483.686141970031;4602.88492787683;4618.168729628632;4651.395318608559;1880.539267879351;1898.943031709051;1938.738270333487;1948.5226119600504;1959.6668566343756;818.3698552114838;916.6516723645105;1021.7139201023725;1054.520193312041;1083.5990683447176;20426;21324.14703411877;21473.248436304653;21629.134834606753;21656.566868662852;854.8546747053016;979.2215188924822;1005.3917379985004;1056.3556230699267;1062.7449412141184;11290.266132701348;11401.372924489067;11421.486033128529;11544.653660390202;12306.938465307616;677667;731662;736996;742961;743307;130944.34527827491;131507.34246328706;131948.68051319555;132333.3383333077;137489;1116.3357802107732;1129.1926272715048;1174.2954227463454;1197.874223206568;1200.327816422806;19432.611347773247;19894.90052549728;20168.697469537674;20543.178272868918;20595.8970205148;47729.045419092115;51832;54339.45660543502;56683.86632267414;57013.71493142508;82900.58549707213;84925;85710.57144714237;86830;88657;7802.765917022499;8008.239217274583;8366.498010119412;8763.824723505622;9012.504312262889;12978.740425191632;13779.862201378259;13884.305784710927;14067.085639433404;14271.215083170526;11325.830112548154;11683.824742628698;11720.589779357682;11906.76186476283;12147;7887.487313324616;10917.290376125526;11489.161734122501;11845.703857403634;11935.76128477443;11364.659060228207;12100.818487722516;12104.818427723767;12154.1492095556;12357.814632780695;8320.958395207985;8379.70671026511;8422.536760477988;8682.782930426538;8830.42602230853;11493;11967.64097077089;12026.218295810744;12207.45066471993;12300.200486968319 10:15:06 INFO - PROCESS | 2516 | |3;mootools.html;1344.623505418483;1442.3797766960206;1484.9456885611216;1874.8500119990401;1973.8847551133608;8350.248477637011;9137.588808503617;9379.671711490098;9382.01488843671;9383.953080234589;8386.329093672506;8479.576021198945;8869.246114080312;9171.037041110687;9191.264698824094;2539.5555777738914;2568.4092658688514;2570.0362364113457;2571.9357016074655;2575.9227223183243;2203;2491.638712386703;2526.9639447826394;2585.340738111788;2585.9094931677396;2562.359410147463;2585.547529182395;2601.531724289627;2604.4140068484535;2608.4783043391303;2559.78241849443;2574.781143602796;2577.445849142434;2593.2220333899754;2599.454114635929;2553.7190908999996;2581.7547333003336;2604.270804174834;2611.229687242268;2618.3061488705507;9022.548872556412;9256.583453744597;9303.906960930371;9343;9393.154616084585;5664.433556644344;5832.854178645525;5906.350301466835;5914.585978981473;5924.555658325599;3719.5350581177354;3821.847126114952;3853.8265778039777;3889.3193691104225;3891.4357418174204;949.9572519236582;1067.0609863320306;1076.983845242322;1089.5696200001034;1106.2919731371928;12442.502299908083;12621.242725436503;12659.113862029662;12695.492180312776;12703.364831758376;4864;4882.121218180761;4890.755462226874;4919;4961.7271050092595;9822;9824.017598240262;9826.65606703762;9839.016098390246;9846.359986600848;5635.126555383922;5653.858653533613;5696.917585658712;5698.088305871041;5715.342735585377;4668.50980647034;4770.522947705202;5031.245313203049;5166.3800343958965;5218.582513398919;3536.2750636119536;3567.785932843986;3876.069743261597;3912.8043597819997;3924.1955399143108;1233.5497543396775;1238.9442475088642;1244.564402459132;1256.2839181666363;1261.627819793145;1422.3954819201797;1449.2246648043456;1457.4753088887992;1477.7266205751755;1481.888858335629;8716.08481109487;8720.78198045054;8749.781255468537;8776.25401840838;8795.51624660637;535.7856857257128;543.5597166295235;544.042485226005;546.0280700353377;548.3009163316723;6489.967550162219;6497.350264973465;6564.409203171737;6601.603903765789;6602.669866506655;11157.49791259379;11686.24039437434;11699.707507312385;11705;11744.354060526583;11224.94387528057;11379.715507112223;11434.256773309875;11468.655940321803;11525.250858694159;8927.285817134614;9039.45763254207;9095.31785116119;9101.726948191432;9104.681336153202;8253.876191857007;8410.915890841014;8537.74386768398;8541.87187192205;8564.785880353042;9925.602975880884;9983.60065597368;10057.597696092367;10075.294729368874;10081.69754907354;10149.137323327599;10172.796544069226;10478.318909270873;10580.84128738085;10615.150787936793;5996.850078748066;7036.753713619999;7659.578723170056;7835.764927052198;8007;8648.740537783624;8669.003064647646;8712.21590056898;8717.607707653044;8723.65105395777;7591.43064270193;7639.312461878458;7718;7768.378529717496;7792.103908050647;7414.592197429193;7509.51188172767;7551.773446796605;7664;7681.615919203906;8029.919700803151;8223.712170074019;8238.464499807493;8239.95880020596;8247.793805154919;7292.744753933587;7337.229590892879;7359.227281135403;7389.667464964197;7389.7413590524075;7493.325600695964;7507.249275072449;7556.58438785872;7558.433117516099;7577.734779282699 10:15:06 INFO - PROCESS | 2516 | |4;prototype.html;331.8125259228534;337.16887871397006;337.4566947214985;343.1096305088295;347.4330768235259;6675.899861502081;6728.663566821664;6756.7635132770365;6766.323367663231;6771.492138089645;6709.563878347916;6724.0922475465795;6730;6744.898826517606;6756.527043106972;4778;4888.41339039314;4919.852404427873;4974.502549745023;4991.475895031024;4013.2776100301935;4955.984023275238;4989.101961646902;4996.925046124311;5008.198688209887;4931.482194369593;4936.210206366982;4941.135301322272;4946.1838796598695;4983.177775667011;4742.383490146276;4816.229403295456;4918.188498897677;4925.236588328815;4939.876503087452;4248.214080395106;4266.31738921771;4272.807723652443;4279.679024073176;4284.250256205183;6442.355764423567;6572.76995305162;6589.275179730226;6595.208574970986;6596.769113081067;5951.375105613892;5955.702214889281;5970.761169553212;5974.581779275452;5974.61165024272;6856.142982127234;7212;7225.349718525358;7228.783136505913;7233.855322893565;4675.649326300541;4680.625549955996;4709.411323584552;4712.387389639359;4720.858374248778;6498.610083395011;7258.455615828834;7504.474686771928;7605.6577454014705;7616.162222155558;4751.144793937125;4761.809527618856;4762;4763.214069678534;4768.928466073012;4824.469308376076;4825.975870120697;4827.493113223061;4830.985493046429;4860.736208585793;5537.58468114893;5758.510526605201;5770.913436298459;5775.88448231033;5794.391588883191;6405.455536279375;6690.431313338323;7215.314545118205;7216.314450127229;7241.986121942932;1455.4251070827177;1528.5949223455793;1635.3703824027834;1671.147714665505;1683.6380178261732;1013.4426065663855;1040.5213601743283;1059.7615536504225;1064.9254552181428;1088.542812018938;6744.258131605519;6931.549449285781;6933.341332573397;6936.722531098801;6938.41023512997;7562.470627056164;7582.62086895664;7588.62056897153;7593.544387336778;7600.581967991813;6903.965480172567;6907.033015377851;6908.6545672716165;6916.965415172993;6918.308169183142;3872.283627528916;3960.881173564798;4002.9199416012098;4011.8194681239415;4031.7782521960985;7860.724874629361;7913.446058775946;7922.445428819928;7938.285554300141;7946.523208607502;7783.688652453951;7795.883061754078;7799.376049916106;7801.024871891013;7801.648925798353;7877.921220787719;7882.7241046563095;7886.44794864354;7886.881696774553;7895.368370530229;7242.601656908921;7481.588512631857;7511.699532018658;7512.361449276873;7548;7318.96340518294;7373.8156546086775;7374.889376659462;7384;7386.556806591621;7858.292753652198;7882.448228623941;7886.408519360956;7897.210278972057;7904.170062143622;4756.571908528249;4800.7599620019555;4807.399075115611;4808.543188397097;4810;7286.817829554304;7442.4790264683115;7498.850022999619;7506.174320824595;7514.346843694379;7232.0959880015;7251.057362542836;7262.527935684164;7266.745663901738;7277.38142257914;7146.892796608159;7236.095488063992;7280.235575264521;7291.234420385783;7301.598412087386;7100.964495177491;7104.431645468247;7112.182099058467;7124.715011399486;7124.857502850017;7020.192677842114;7247.2390399007345;7247.8550428990075;7254.419646428168;7267.091613548307;6827.692753826189;6945.826354341182;6958;6966.7213311469;6981.823270412052 10:15:06 INFO - PROCESS | 2516 | |5;yui.html;672.1967249137281;713.7858642407276;727.9526830756;731.7512045904391;805.9758207253781;15597;15834.28745706443;15928.920355398206;15981.760273595877;15995.360185592563;14660.340284687189;14815.259237038132;14885.479008234714;14892.702145957075;15060.472883449082;969.5394687523441;969.8254314223437;982.5283863745407;982.5774916785779;984.6110786239431;816.9754907352789;829.8423299573092;973.3332667123008;999.8250306196422;1003.002012997069;932.9813403731921;1014.8528463372807;1066.3708412036935;1070.6787963610925;1072.104792498265;842.9199226073513;1058.4284486377346;1062.54310646422;1063.7659714862718;1066.109798318405;774.8334108166715;790.0795573157264;790.0835031363648;792.5482474989259;793.8928244686952;15675.05949643025;15699.921500392538;15725;15749.448769293134;15750.448734294245;11305.547778088867;12904.80642790359;12993.480260789556;13046.673833154153;13195.812376886126;8350.791230219233;10417.739556511073;10524.947375263151;10621.787564248672;10956.835647465294;3624.9093772655633;3635.63643635637;3646.6171052039685;3690.9630903690886;3769.9623003769884;92663.53668231616;93097.53451232768;94445.52777236138;94464;94539.99999999932;9696.854547181798;9835.96722344158;9905.702828915;9952.601895924083;10167;22368.776312236994;22610.66084008741;22624.886875565517;22625.660615090786;22785.316440506813;7653.0816302042995;7685.308322251024;7848.332891704269;7882.211778822072;7930.206979302024;4206.07466357407;4269.978650106729;4313.61177494027;4355.15074560464;4368.060866913629;3734.8879533614036;3778.471014058034;3779.244151169777;3779.7165212609166;3781.4516895050065;572.7565784541553;668.1981622053555;681.9727210911508;682.9180498340131;685.6732223148224;622.243973572112;627.0500192208807;634.194572892424;636.6439483899264;643.7521554201666;7112.537685050455;8242.134575869448;8429.913626299136;8550.914490855137;9049.909500905038;614.923134608174;635.1711017122607;641.5156556799586;644.3170239546096;680;3951.5060617422823;3984.322665146932;4033.8100260423244;4076.694247931417;4080.5511393746665;85529.71705424423;91912.54043729873;99446.01107977799;99579.50210248903;99614.5019274899;65595.0321490356;78071.60964195142;82544.17455825485;83018.58490707508;83956.16043839605;75290.87063694048;75357;75482;75909.24090759132;76602;8543.145685431657;8597.699080532151;8703.521306327959;8756.51839148853;8951.820963580562;51702.96594068173;52136.739316303174;53011.4698853022;55671.32986010426;55768;71997.28002719906;71998.28001719915;72259;73651;76551;11355.602553910574;11374.260673056226;11655.475503602189;11697.415129243675;12038.337891416057;12025.879741202476;12128.272303661808;12225;12310.13829031995;12396;11825.349605771766;11959.940200298943;12001.699957501132;12058.879411205775;12178.756424871275;10098.343607665478;11639.370488131837;12394.690132746753;12443;12448.688782780502;9246.537673116452;11912.927836494757;12048.518059277882;12115.939420302842;12143;9874.160696340605;10119.696409107739;10144.391336519833;10153.238507112144;10246.487675616041;9937.552810123418;10059.59214914434;10059.647912323033;10071.244656650928;10133.240006999356 10:15:06 INFO - PROCESS | 2516 | __end_tp_report 10:15:06 INFO - PROCESS | 2516 | __start_cc_report 10:15:06 INFO - PROCESS | 2516 | _x_x_mozilla_cycle_collect,1263 10:15:06 INFO - PROCESS | 2516 | __end_cc_report 10:15:06 INFO - PROCESS | 2516 | __startTimestamp1462554906895__endTimestamp 10:15:06 INFO - PROCESS | 2516 | 10:15:06 INFO - PROCESS | 2516 | ------- Summary: start ------- 10:15:06 INFO - PROCESS | 2516 | Number of tests: 6 10:15:06 INFO - PROCESS | 2516 | 10:15:06 INFO - PROCESS | 2516 | [#0] dojo.html Cycles:165 Average:5925.84 Median:6195.94 stddev:645.66 (10.4%) stddev-sans-first:619.86 10:15:06 INFO - PROCESS | 2516 | Values: 3537.6 3608.1 3611.1 3629.7 3692.9 6005.1 6011.9 6040.7 6048.5 6052.4 6057.3 6064.7 6066.9 6071.6 6078.2 5288.0 5382.7 5400.5 5467.5 5499.1 5477.2 5478.9 5480.2 5483.0 5486.5 5050.4 5400.2 5448.3 5474.0 5479.1 4462.5 4557.5 4639.9 5507.0 5512.2 5315.6 5336.1 5394.1 5412.6 5416.5 5345.9 5783.0 5794.3 5802.5 5836.0 6187.0 6287.0 6288.4 6297.8 6317.8 6284.3 6319.4 6320.0 6351.0 6380.6 6125.8 6150.1 6160.6 6164.3 6173.3 6357.0 6478.5 6532.2 6534.8 6544.7 6241.4 6271.9 6294.1 6299.0 6300.9 6403.1 6409.4 6412.8 6415.3 6433.5 6193.0 6195.9 6208.9 6291.8 6316.9 6245.2 6264.0 6290.2 6319.7 6321.8 5133.1 5144.5 5146.5 5146.7 5159.5 4501.3 4580.5 4597.0 4611.6 4671.8 6004.3 6027.9 6034.8 6058.5 6067.2 6252.5 6267.0 6352.0 6406.2 6440.2 6016.2 6055.1 6060.8 6084.5 6089.5 5535.2 5540.9 5545.1 5553.9 5562.4 6386.6 6483.2 6561.2 6583.4 6604.2 6375.1 6390.7 6419.7 6423.3 6441.9 6432.4 6672.4 6678.7 6693.4 6700.1 6233.2 6257.6 6315.5 6319.8 6328.8 6350.2 6359.0 6367.2 6392.1 6400.1 6095.4 6183.9 6246.6 6249.1 6255.2 6176.3 6251.2 6261.2 6262.4 6264.9 6148.7 6199.5 6202.7 6209.4 6217.6 6193.8 6199.7 6205.9 6216.6 6264.6 6222.3 6254.9 6261.6 6264.2 6267.5 10:15:06 INFO - PROCESS | 2516 | 10:15:06 INFO - PROCESS | 2516 | [#1] ext.html Cycles:180 Average:65232.05 Median:35948.37 stddev:130143.28 (362.0%) stddev-sans-first:130417.56 10:15:06 INFO - PROCESS | 2516 | Values: 481.3 532.4 578.2 594.3 672.8 41865.4 42436.6 42519.1 42553.1 42566.8 45816.9 46219.5 46337.0 46377.8 46556.0 9758.3 9950.2 9956.6 9963.2 9963.8 8383.2 10039.9 10046.0 10070.5 10123.8 10055.4 10147.4 10157.6 10183.3 10213.3 10043.1 10125.0 10138.5 10139.5 10141.4 9958.4 10058.5 10091.6 10095.9 10103.9 42630.8 43893.0 44008.6 44514.8 44564.8 3387.7 3464.3 3472.8 3530.0 3570.9 29197.9 30111.7 30202.4 30250.7 30557.4 2839.5 2872.0 2877.7 2885.6 2947.9 510629.1 515097.0 515645.4 516393.0 516506.0 74455.3 74873.5 75333.0 75395.6 75511.6 79194.6 82337.6 82673.6 82691.6 82815.6 18958.1 19198.9 19220.2 19256.7 19300.6 14624.4 14693.4 14740.3 14748.9 14772.3 18527.2 20186.8 21113.7 21753.7 24131.5 7592.6 7854.8 9441.6 9535.3 9551.3 1024.2 1110.8 1123.6 1135.8 1153.9 30977.4 31525.8 31606.0 31954.8 32303.7 1013.2 1182.9 1188.5 1196.8 1319.6 11983.3 14064.1 15773.5 16999.2 17046.8 561962.0 568932.0 571977.0 572520.0 572868.0 57965.8 63968.4 66010.0 66233.3 66368.0 1407.3 1428.7 1514.6 1540.9 1561.3 26685.9 29864.9 31947.7 32338.0 32347.0 53038.7 53407.2 53450.0 53471.7 53528.7 311873.0 360876.0 374329.0 374750.0 374755.0 31061.4 35422.2 35775.8 36296.8 36301.0 46887.8 47085.5 48247.5 48716.5 49510.8 38365.4 38642.8 39784.6 39811.4 40769.0 38573.6 38978.0 39315.6 39736.0 39854.8 38451.4 41313.8 41659.0 42736.8 42786.1 33550.7 35288.6 35724.1 35853.3 36043.5 26626.2 26665.0 26699.3 26953.3 27125.7 10:15:06 INFO - PROCESS | 2516 | 10:15:06 INFO - PROCESS | 2516 | [#2] jquery.html Cycles:180 Average:39008.98 Median:11595.47 stddev:120396.65 (1038.3%) stddev-sans-first:120699.35 10:15:06 INFO - PROCESS | 2516 | Values: 325.7 381.7 382.9 392.4 393.3 20522.4 20547.9 20599.8 21506.7 21530.9 20747.0 21050.6 21056.5 21075.1 21653.7 5760.1 6080.1 6099.2 6105.7 6132.1 4156.1 4355.1 5683.5 5923.4 6177.9 6129.9 6162.2 6166.3 6166.9 6174.6 4120.8 6059.5 6529.0 6703.8 6705.6 4236.0 5642.1 5873.9 5882.4 5899.1 14286.5 14288.9 14311.9 18130.7 25562.9 2115.9 2231.2 2296.3 2425.2 2508.9 10825.4 11787.9 13392.4 15061.4 15307.3 1645.4 1743.8 1773.1 1792.3 1839.3 111346.4 115414.0 116995.0 117427.4 117609.4 9710.0 10381.1 10728.4 10964.3 11685.4 14919.9 14923.0 14935.2 14945.9 14983.5 9007.6 9086.6 9089.7 9175.6 9206.5 9175.4 9202.4 9259.8 9280.5 9309.1 3728.9 4483.7 4602.9 4618.2 4651.4 1880.5 1898.9 1938.7 1948.5 1959.7 818.4 916.7 1021.7 1054.5 1083.6 20426.0 21324.1 21473.2 21629.1 21656.6 854.9 979.2 1005.4 1056.4 1062.7 11290.3 11401.4 11421.5 11544.7 12306.9 677667.0 731662.0 736996.0 742961.0 743307.0 130944.3 131507.3 131948.7 132333.3 137489.0 1116.3 1129.2 1174.3 1197.9 1200.3 19432.6 19894.9 20168.7 20543.2 20595.9 47729.0 51832.0 54339.5 56683.9 57013.7 82900.6 84925.0 85710.6 86830.0 88657.0 7802.8 8008.2 8366.5 8763.8 9012.5 12978.7 13779.9 13884.3 14067.1 14271.2 11325.8 11683.8 11720.6 11906.8 12147.0 7887.5 10917.3 11489.2 11845.7 11935.8 11364.7 12100.8 12104.8 12154.1 12357.8 8321.0 8379.7 8422.5 8682.8 8830.4 11493.0 11967.6 12026.2 12207.5 12300.2 10:15:06 INFO - PROCESS | 2516 | 10:15:06 INFO - PROCESS | 2516 | [#3] mootools.html Cycles:180 Average:6333.68 Median:547.16 stddev:3402.95 (621.9%) stddev-sans-first:3391.83 10:15:06 INFO - PROCESS | 2516 | Values: 1344.6 1442.4 1484.9 1874.9 1973.9 8350.2 9137.6 9379.7 9382.0 9384.0 8386.3 8479.6 8869.2 9171.0 9191.3 2539.6 2568.4 2570.0 2571.9 2575.9 2203.0 2491.6 2527.0 2585.3 2585.9 2562.4 2585.5 2601.5 2604.4 2608.5 2559.8 2574.8 2577.4 2593.2 2599.5 2553.7 2581.8 2604.3 2611.2 2618.3 9022.5 9256.6 9303.9 9343.0 9393.2 5664.4 5832.9 5906.4 5914.6 5924.6 3719.5 3821.8 3853.8 3889.3 3891.4 950.0 1067.1 1077.0 1089.6 1106.3 12442.5 12621.2 12659.1 12695.5 12703.4 4864.0 4882.1 4890.8 4919.0 4961.7 9822.0 9824.0 9826.7 9839.0 9846.4 5635.1 5653.9 5696.9 5698.1 5715.3 4668.5 4770.5 5031.2 5166.4 5218.6 3536.3 3567.8 3876.1 3912.8 3924.2 1233.5 1238.9 1244.6 1256.3 1261.6 1422.4 1449.2 1457.5 1477.7 1481.9 8716.1 8720.8 8749.8 8776.3 8795.5 535.8 543.6 544.0 546.0 548.3 6490.0 6497.4 6564.4 6601.6 6602.7 11157.5 11686.2 11699.7 11705.0 11744.4 11224.9 11379.7 11434.3 11468.7 11525.3 8927.3 9039.5 9095.3 9101.7 9104.7 8253.9 8410.9 8537.7 8541.9 8564.8 9925.6 9983.6 10057.6 10075.3 10081.7 10149.1 10172.8 10478.3 10580.8 10615.2 5996.9 7036.8 7659.6 7835.8 8007.0 8648.7 8669.0 8712.2 8717.6 8723.7 7591.4 7639.3 7718.0 7768.4 7792.1 7414.6 7509.5 7551.8 7664.0 7681.6 8029.9 8223.7 8238.5 8240.0 8247.8 7292.7 7337.2 7359.2 7389.7 7389.7 7493.3 7507.2 7556.6 7558.4 7577.7 10:15:06 INFO - PROCESS | 2516 | 10:15:06 INFO - PROCESS | 2516 | [#4] prototype.html Cycles:180 Average:5941.44 Median:6756.65 stddev:1911.95 (28.3%) stddev-sans-first:1870.38 10:15:06 INFO - PROCESS | 2516 | Values: 331.8 337.2 337.5 343.1 347.4 6675.9 6728.7 6756.8 6766.3 6771.5 6709.6 6724.1 6730.0 6744.9 6756.5 4778.0 4888.4 4919.9 4974.5 4991.5 4013.3 4956.0 4989.1 4996.9 5008.2 4931.5 4936.2 4941.1 4946.2 4983.2 4742.4 4816.2 4918.2 4925.2 4939.9 4248.2 4266.3 4272.8 4279.7 4284.3 6442.4 6572.8 6589.3 6595.2 6596.8 5951.4 5955.7 5970.8 5974.6 5974.6 6856.1 7212.0 7225.3 7228.8 7233.9 4675.6 4680.6 4709.4 4712.4 4720.9 6498.6 7258.5 7504.5 7605.7 7616.2 4751.1 4761.8 4762.0 4763.2 4768.9 4824.5 4826.0 4827.5 4831.0 4860.7 5537.6 5758.5 5770.9 5775.9 5794.4 6405.5 6690.4 7215.3 7216.3 7242.0 1455.4 1528.6 1635.4 1671.1 1683.6 1013.4 1040.5 1059.8 1064.9 1088.5 6744.3 6931.5 6933.3 6936.7 6938.4 7562.5 7582.6 7588.6 7593.5 7600.6 6904.0 6907.0 6908.7 6917.0 6918.3 3872.3 3960.9 4002.9 4011.8 4031.8 7860.7 7913.4 7922.4 7938.3 7946.5 7783.7 7795.9 7799.4 7801.0 7801.6 7877.9 7882.7 7886.4 7886.9 7895.4 7242.6 7481.6 7511.7 7512.4 7548.0 7319.0 7373.8 7374.9 7384.0 7386.6 7858.3 7882.4 7886.4 7897.2 7904.2 4756.6 4800.8 4807.4 4808.5 4810.0 7286.8 7442.5 7498.9 7506.2 7514.3 7232.1 7251.1 7262.5 7266.7 7277.4 7146.9 7236.1 7280.2 7291.2 7301.6 7101.0 7104.4 7112.2 7124.7 7124.9 7020.2 7247.2 7247.9 7254.4 7267.1 6827.7 6945.8 6958.0 6966.7 6981.8 10:15:06 INFO - PROCESS | 2516 | 10:15:06 INFO - PROCESS | 2516 | [#5] yui.html Cycles:180 Average:19429.76 Median:28035.51 stddev:27620.63 (98.5%) stddev-sans-first:27662.20 10:15:06 INFO - PROCESS | 2516 | Values: 672.2 713.8 728.0 731.8 806.0 15597.0 15834.3 15928.9 15981.8 15995.4 14660.3 14815.3 14885.5 14892.7 15060.5 969.5 969.8 982.5 982.6 984.6 817.0 829.8 973.3 999.8 1003.0 933.0 1014.9 1066.4 1070.7 1072.1 842.9 1058.4 1062.5 1063.8 1066.1 774.8 790.1 790.1 792.5 793.9 15675.1 15699.9 15725.0 15749.4 15750.4 11305.5 12904.8 12993.5 13046.7 13195.8 8350.8 10417.7 10524.9 10621.8 10956.8 3624.9 3635.6 3646.6 3691.0 3770.0 92663.5 93097.5 94445.5 94464.0 94540.0 9696.9 9836.0 9905.7 9952.6 10167.0 22368.8 22610.7 22624.9 22625.7 22785.3 7653.1 7685.3 7848.3 7882.2 7930.2 4206.1 4270.0 4313.6 4355.2 4368.1 3734.9 3778.5 3779.2 3779.7 3781.5 572.8 668.2 682.0 682.9 685.7 622.2 627.1 634.2 636.6 643.8 7112.5 8242.1 8429.9 8550.9 9049.9 614.9 635.2 641.5 644.3 680.0 3951.5 3984.3 4033.8 4076.7 4080.6 85529.7 91912.5 99446.0 99579.5 99614.5 65595.0 78071.6 82544.2 83018.6 83956.2 75290.9 75357.0 75482.0 75909.2 76602.0 8543.1 8597.7 8703.5 8756.5 8951.8 51703.0 52136.7 53011.5 55671.3 55768.0 71997.3 71998.3 72259.0 73651.0 76551.0 11355.6 11374.3 11655.5 11697.4 12038.3 12025.9 12128.3 12225.0 12310.1 12396.0 11825.3 11959.9 12001.7 12058.9 12178.8 10098.3 11639.4 12394.7 12443.0 12448.7 9246.5 11912.9 12048.5 12115.9 12143.0 9874.2 10119.7 10144.4 10153.2 10246.5 9937.6 10059.6 10059.6 10071.2 10133.2 10:15:06 INFO - PROCESS | 2516 | -------- Summary: end -------- 10:15:06 INFO - PROCESS | 2516 | 10:15:07 INFO - TEST-INFO | 2516: exit 0 10:15:07 INFO - TEST-OK | dromaeo_css | took 1111809ms 10:15:07 INFO - TEST-START | kraken 10:15:07 INFO - operating with platform_type : mac_ 10:15:07 INFO - Initialising browser for kraken test... 10:15:07 INFO - TEST-INFO | started process 2518 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpyTbLFw/profile http://localhost:53195/getInfo.html) 10:15:09 INFO - PROCESS | 2518 | __metrics Screen width/height:1600/1200 10:15:09 INFO - PROCESS | 2518 | colorDepth:24 10:15:09 INFO - PROCESS | 2518 | Browser inner width/height: 1024/689 10:15:09 INFO - PROCESS | 2518 | __metrics 10:15:09 INFO - PROCESS | 2518 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:15:09 INFO - PROCESS | 2518 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:15:10 INFO - TEST-INFO | 2518: exit 0 10:15:10 INFO - Browser initialized. 10:15:10 INFO - Running cycle 1/1 for kraken test... 10:15:10 INFO - TEST-INFO | started process 2521 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpyTbLFw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:22 INFO - PROCESS | 2521 | RSS: Main: 157118464 10:15:22 INFO - PROCESS | 2521 | 10:15:24 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:53195/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53195/tests/kraken/driver.html?testName=audio-beat-detection) 10:15:25 INFO - PROCESS | 2521 | RSS: Main: 213299200 10:15:25 INFO - PROCESS | 2521 | 10:15:27 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:53195/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53195/tests/kraken/driver.html?testName=audio-dft) 10:15:28 INFO - PROCESS | 2521 | RSS: Main: 224018432 10:15:28 INFO - PROCESS | 2521 | 10:15:31 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:53195/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53195/tests/kraken/driver.html?testName=audio-fft) 10:15:32 INFO - PROCESS | 2521 | RSS: Main: 214269952 10:15:32 INFO - PROCESS | 2521 | 10:15:34 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:53195/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53195/tests/kraken/driver.html?testName=audio-oscillator) 10:15:34 INFO - PROCESS | 2521 | RSS: Main: 215478272 10:15:34 INFO - PROCESS | 2521 | 10:15:36 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:53195/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53195/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:15:37 INFO - PROCESS | 2521 | RSS: Main: 216084480 10:15:37 INFO - PROCESS | 2521 | 10:15:40 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:53195/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53195/tests/kraken/driver.html?testName=imaging-darkroom) 10:15:40 INFO - PROCESS | 2521 | RSS: Main: 216215552 10:15:40 INFO - PROCESS | 2521 | 10:15:43 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:53195/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53195/tests/kraken/driver.html?testName=imaging-desaturate) 10:15:44 INFO - PROCESS | 2521 | RSS: Main: 216363008 10:15:44 INFO - PROCESS | 2521 | 10:15:46 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:53195/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53195/tests/kraken/driver.html?testName=json-parse-financial) 10:15:47 INFO - PROCESS | 2521 | RSS: Main: 216838144 10:15:47 INFO - PROCESS | 2521 | 10:15:48 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:53195/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53195/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:15:49 INFO - PROCESS | 2521 | RSS: Main: 250712064 10:15:49 INFO - PROCESS | 2521 | 10:15:51 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:53195/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53195/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:15:52 INFO - PROCESS | 2521 | RSS: Main: 250601472 10:15:52 INFO - PROCESS | 2521 | 10:15:54 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:53195/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53195/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:15:54 INFO - PROCESS | 2521 | RSS: Main: 255561728 10:15:54 INFO - PROCESS | 2521 | 10:15:57 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:53195/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:15:57 INFO - PROCESS | 2521 | RSS: Main: 256864256 10:15:57 INFO - PROCESS | 2521 | 10:16:00 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:53195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:16:00 INFO - PROCESS | 2521 | RSS: Main: 256950272 10:16:00 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | Cycle 1(1): loaded http://localhost:53195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53195/tests/kraken/driver.html?testName=ai-astar) 10:16:02 INFO - PROCESS | 2521 | RSS: Main: 320167936 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | __start_tp_report 10:16:02 INFO - PROCESS | 2521 | _x_x_mozilla_page_load 10:16:02 INFO - PROCESS | 2521 | _x_x_mozilla_page_load_details 10:16:02 INFO - PROCESS | 2521 | |i|pagename|runs| 10:16:02 INFO - PROCESS | 2521 | |0;ai-astar;111;110;110;110;112;111;119;112;109;111 10:16:02 INFO - PROCESS | 2521 | |1;audio-beat-detection;156;129;191;182;146;139;118;146;148;118 10:16:02 INFO - PROCESS | 2521 | |2;audio-dft;183;183;182;185;182;208;262;197;183;184 10:16:02 INFO - PROCESS | 2521 | |3;audio-fft;73;75;73;120;55;57;57;57;120;58 10:16:02 INFO - PROCESS | 2521 | |4;audio-oscillator;91;89;131;81;78;80;116;74;80;118 10:16:02 INFO - PROCESS | 2521 | |5;imaging-gaussian-blur;87;84;87;84;87;84;88;85;87;84 10:16:02 INFO - PROCESS | 2521 | |6;imaging-darkroom;93;93;93;93;93;93;93;93;93;92 10:16:02 INFO - PROCESS | 2521 | |7;imaging-desaturate;87;86;87;86;85;87;83;71;105;135 10:16:02 INFO - PROCESS | 2521 | |8;json-parse-financial;55;58;58;58;59;59;58;59;54;53 10:16:02 INFO - PROCESS | 2521 | |9;json-stringify-tinderbox;62;60;69;70;77;73;70;67;66;67 10:16:02 INFO - PROCESS | 2521 | |10;stanford-crypto-aes;81;81;80;79;80;80;80;79;81;85 10:16:02 INFO - PROCESS | 2521 | |11;stanford-crypto-ccm;119;130;135;132;113;121;124;134;130;129 10:16:02 INFO - PROCESS | 2521 | |12;stanford-crypto-pbkdf2;134;133;137;138;171;158;135;131;134;132 10:16:02 INFO - PROCESS | 2521 | |13;stanford-crypto-sha256-iterative;56;73;94;96;76;67;65;67;66;65 10:16:02 INFO - PROCESS | 2521 | __end_tp_report 10:16:02 INFO - PROCESS | 2521 | __start_cc_report 10:16:02 INFO - PROCESS | 2521 | _x_x_mozilla_cycle_collect,1190 10:16:02 INFO - PROCESS | 2521 | __end_cc_report 10:16:02 INFO - PROCESS | 2521 | __startTimestamp1462554962887__endTimestamp 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | ------- Summary: start ------- 10:16:02 INFO - PROCESS | 2521 | Number of tests: 14 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:2.80 (2.5%) stddev-sans-first:2.96 10:16:02 INFO - PROCESS | 2521 | Values: 111.0 110.0 110.0 110.0 112.0 111.0 119.0 112.0 109.0 111.0 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:147.00 stddev:24.30 (16.5%) stddev-sans-first:25.57 10:16:02 INFO - PROCESS | 2521 | Values: 156.0 129.0 191.0 182.0 146.0 139.0 118.0 146.0 148.0 118.0 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | [#2] audio-dft Cycles:10 Average:194.90 Median:184.50 stddev:25.06 (13.6%) stddev-sans-first:26.21 10:16:02 INFO - PROCESS | 2521 | Values: 183.0 183.0 182.0 185.0 182.0 208.0 262.0 197.0 183.0 184.0 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | [#3] audio-fft Cycles:10 Average:74.50 Median:57.50 stddev:25.20 (43.8%) stddev-sans-first:26.73 10:16:02 INFO - PROCESS | 2521 | Values: 73.0 75.0 73.0 120.0 55.0 57.0 57.0 57.0 120.0 58.0 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:80.00 stddev:20.22 (25.3%) stddev-sans-first:21.42 10:16:02 INFO - PROCESS | 2521 | Values: 91.0 89.0 131.0 81.0 78.0 80.0 116.0 74.0 80.0 118.0 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:87.00 stddev:1.64 (1.9%) stddev-sans-first:1.67 10:16:02 INFO - PROCESS | 2521 | Values: 87.0 84.0 87.0 84.0 87.0 84.0 88.0 85.0 87.0 84.0 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:16:02 INFO - PROCESS | 2521 | Values: 93.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 92.0 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | [#7] imaging-desaturate Cycles:10 Average:91.20 Median:86.00 stddev:17.42 (20.3%) stddev-sans-first:18.41 10:16:02 INFO - PROCESS | 2521 | Values: 87.0 86.0 87.0 86.0 85.0 87.0 83.0 71.0 105.0 135.0 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:58.00 stddev:2.23 (3.9%) stddev-sans-first:2.24 10:16:02 INFO - PROCESS | 2521 | Values: 55.0 58.0 58.0 58.0 59.0 59.0 58.0 59.0 54.0 53.0 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:69.50 stddev:4.95 (7.1%) stddev-sans-first:4.74 10:16:02 INFO - PROCESS | 2521 | Values: 62.0 60.0 69.0 70.0 77.0 73.0 70.0 67.0 66.0 67.0 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:1.71 (2.1%) stddev-sans-first:1.81 10:16:02 INFO - PROCESS | 2521 | Values: 81.0 81.0 80.0 79.0 80.0 80.0 80.0 79.0 81.0 85.0 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:130.00 stddev:7.18 (5.5%) stddev-sans-first:7.06 10:16:02 INFO - PROCESS | 2521 | Values: 119.0 130.0 135.0 132.0 113.0 121.0 124.0 134.0 130.0 129.0 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.30 Median:136.00 stddev:13.28 (9.8%) stddev-sans-first:13.89 10:16:02 INFO - PROCESS | 2521 | Values: 134.0 133.0 137.0 138.0 171.0 158.0 135.0 131.0 134.0 132.0 10:16:02 INFO - PROCESS | 2521 | 10:16:02 INFO - PROCESS | 2521 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:70.00 stddev:12.97 (18.5%) stddev-sans-first:12.31 10:16:02 INFO - PROCESS | 2521 | Values: 56.0 73.0 94.0 96.0 76.0 67.0 65.0 67.0 66.0 65.0 10:16:02 INFO - PROCESS | 2521 | -------- Summary: end -------- 10:16:02 INFO - PROCESS | 2521 | 10:16:03 INFO - TEST-INFO | 2521: exit 0 10:16:03 INFO - TEST-OK | kraken | took 56189ms 10:16:03 INFO - SUITE-END | took 1167s 10:16:04 INFO - Completed test suite (00:19:28) 10:16:04 INFO - javascript benchmark 10:16:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3537.5754909410866, 3608.116011577164, 3611.0972256935765, 3629.6733294003543, 3692.8892133236013, 6005.069214271789, 6011.939880601192, 6040.697965101749, 6048.467654932673, 6052.42501962314, 6057.303410107839, 6064.727087281072, 6066.939330606692, 6071.60534565253, 6078.240219972504, 5287.973560132194, 5382.650127741694, 5400.459954004607, 5467.535259502947, 5499.120140777476, 5477.178423236526, 5478.91781623276, 5480.177973304017, 5483.0, 5486.506214440699, 5050.368703912011, 5400.189971504266, 5448.291722076125, 5474.0, 5479.068558345071, 4462.509123996358, 4557.544245575449, 4639.907201855944, 5506.99999999998, 5512.200236665114, 5315.627906046579, 5336.119540275849, 5394.136938089926, 5412.5940554458175, 5416.485433883775, 5345.919811202835, 5783.0, 5794.304683438015, 5802.535797136219, 5835.978703726831, 6187.0, 6287.0, 6288.371162883721, 6297.779577714804, 6317.842053948642, 6284.340144284875, 6319.399657032621, 6320.0, 6350.9682451587905, 6380.61716297019, 6125.754969801203, 6150.108234306001, 6160.568760186834, 6164.291106522717, 6173.32093469718, 6356.968215158895, 6478.546501744832, 6532.248791388956, 6534.836629084216, 6544.70548825304, 6241.375862413723, 6271.937280627135, 6294.087357333161, 6298.992161254269, 6300.905486417708, 6403.103565500834, 6409.423151916257, 6412.807615771534, 6415.294317625057, 6433.517486188554, 6193.009118541012, 6195.938040619626, 6208.906866397007, 6291.811245662638, 6316.9368306317265, 6245.188125543741, 6264.029075493306, 6290.150829638032, 6319.715612797343, 6321.778737744157, 5133.050385678662, 5144.536991670693, 5146.459621739664, 5146.716930568779, 5159.458256883048, 4501.3022981437925, 4580.496145424001, 4596.97701511497, 4611.5619016193405, 4671.8364857229835, 6004.279486461653, 6027.939720602738, 6034.783475357517, 6058.545609079337, 6067.24159480065, 6252.531060170505, 6267.0286105653695, 6351.9682401588625, 6406.199225096863, 6440.162778838721, 6016.187814644967, 6055.122007308915, 6060.757569697251, 6084.4828189603495, 6089.451949324493, 5535.169724541351, 5540.86147846299, 5545.085060964976, 5553.888922221533, 5562.360328562187, 6386.648734319564, 6483.189601299838, 6561.179852518435, 6583.407493325528, 6604.24051234095, 6375.075614035846, 6390.7443702251385, 6419.743210271724, 6423.261324947691, 6441.871162576816, 6432.35676432353, 6672.399484046459, 6678.732850686112, 6693.364130407604, 6700.061991321317, 6233.2208473940755, 6257.624542527463, 6315.494760419064, 6319.8104056878365, 6328.778492752732, 6350.206224221973, 6359.046143078575, 6367.172267605181, 6392.0731493934045, 6400.103985442135, 6095.420935011167, 6183.876322473436, 6246.562740608114, 6249.0626406039455, 6255.155554000152, 6176.258848938156, 6251.187345645037, 6261.186045814015, 6262.436380725757, 6264.937350626617, 6148.661823599745, 6199.535034872312, 6202.72087756043, 6209.379062093754, 6217.564770466024, 6193.81418557444, 6199.690015499117, 6205.944989351911, 6216.564840461125, 6264.624122552661, 6222.315545290105, 6254.906176407449, 6261.624302541862, 6264.185655864709, 6267.529935254783], "unit": "score", "name": "dojo.html", "value": 5885.767131909865}, {"lowerIsBetter": false, "replicates": [481.29970892351633, 532.4017077737153, 578.1991941161491, 594.3343455330029, 672.7712577723573, 41865.372019419694, 42436.57563424365, 42519.14961700764, 42553.148937021244, 42566.787166064205, 45816.85457863555, 46219.53780462194, 46337.0, 46377.7681111594, 46556.0, 9758.316917815739, 9950.203983681324, 9956.551955161998, 9963.15313198379, 9963.75090622733, 8383.245507904287, 10039.941811928573, 10046.0, 10070.496475176249, 10123.797524049514, 10055.446950417723, 10147.391156530632, 10157.644482443116, 10183.338083024617, 10213.336133151359, 10043.096121349077, 10125.0, 10138.493075346203, 10139.493025348704, 10141.391516508997, 9958.402495850272, 10058.497075146286, 10091.646792362231, 10095.899041009643, 10103.939086395969, 42630.78684606557, 43893.0, 44008.559914400765, 44514.77742611299, 44564.77717611391, 3387.728981681484, 3464.2551851351827, 3472.774269672463, 3529.982350088259, 3570.928581428383, 29197.85401073002, 30111.698883011326, 30202.395952081057, 30250.697493025007, 30557.38885222283, 2839.4746971810073, 2872.0, 2877.6978417266096, 2885.5960165576835, 2947.8673459694364, 510629.12798052264, 515097.0, 515645.42177289247, 516393.0, 516506.0, 74455.25544744592, 74873.50252995019, 75333.0, 75395.62302188454, 75511.62244188743, 79194.60402697949, 82337.58831205925, 82673.58663206645, 82691.58654206811, 82815.58592207001, 18958.14688339028, 19198.94405807666, 19220.231190752213, 19256.711149332772, 19300.613987720448, 14624.415023399157, 14693.412263509554, 14740.262986850614, 14748.926255368655, 14772.26138693061, 18527.166277517543, 20186.798132018786, 21113.73317600918, 21753.69477831335, 24131.517369652858, 7592.620368981528, 7854.8429031419055, 9441.622335106518, 9535.332526723063, 9551.283653726, 1024.2267088348249, 1110.7945030169444, 1123.550579768083, 1135.795556799784, 1153.9192256542128, 30977.380452391277, 31525.842370788, 31606.0, 31954.84022579872, 32303.676963230537, 1013.2198207380424, 1182.9231099978474, 1188.4830098907003, 1196.802527582939, 1319.6107148391056, 11983.28100313984, 14064.08583442073, 15773.526794196192, 16999.23503442348, 17046.82953170477, 561962.0, 568932.0, 571977.0, 572520.0, 572868.0, 57965.8406831861, 63968.36031639624, 66010.0, 66233.33766662369, 66368.0, 1407.2893188939724, 1428.728541577097, 1514.6062023873872, 1540.8536189062245, 1561.2662048837028, 26685.86657066702, 29864.85067574735, 31947.68052319447, 32338.0, 32347.0, 53038.73480632572, 53407.19889201588, 53450.0, 53471.732641336544, 53528.73235633797, 311873.0, 360876.0, 374329.0, 374750.0, 374755.0, 31061.378772423974, 35422.22888855598, 35775.82112089423, 36296.81851590725, 36301.0, 46887.765561171975, 47085.529144709486, 48247.5175248243, 48716.512834871195, 49510.75244623754, 38365.424518632804, 38642.80678596589, 39784.60215397925, 39811.40282895817, 40768.98077548085, 38573.61426385812, 38978.0, 39315.60684393119, 39736.0, 39854.80072599618, 38451.42322865215, 41313.79343103265, 41659.0, 42736.78631606946, 42786.14427711366, 33550.66449335475, 35288.64711352854, 35724.10689732777, 35853.28293434169, 36043.45934811032, 26626.201213963614, 26665.0, 26699.33251668724, 26953.3261668452, 27125.72874271232], "unit": "score", "name": "ext.html", "value": 21145.553174517543}, {"lowerIsBetter": false, "replicates": [325.6613122352753, 381.68510978442777, 382.8564288391854, 392.4427313215234, 393.26459520696267, 20522.38432847015, 20547.897260513695, 20599.794002059974, 21506.677399839016, 21530.89234553829, 20747.0, 21050.578988420224, 21056.473588160305, 21075.05162267698, 21653.67519487209, 5760.107183386572, 6080.087986801971, 6099.176611157503, 6105.725242364104, 6132.110843927628, 4156.127213285198, 4355.107203023373, 5683.545316374701, 5923.407659234063, 6177.876442471171, 6129.877402451948, 6162.1681073055015, 6166.260048794151, 6166.907496387557, 6174.629522228658, 4120.75275483469, 6059.484943779762, 6528.967355163218, 6703.8324041899095, 6705.597664140168, 4235.98336399265, 5642.125470552071, 5873.911891321633, 5882.411758824126, 5899.056151015817, 14286.499972500913, 14288.857111428857, 14311.928440357835, 18130.730848840587, 25562.87218563914, 2115.883626400547, 2231.230225572175, 2296.311106667993, 2425.248173066355, 2508.8745562721792, 10825.350478971208, 11787.941060294643, 13392.397342119531, 15061.397544098223, 15307.31117099722, 1645.3829813819818, 1743.808181100078, 1773.1488885334982, 1792.345793785272, 1839.3194518028415, 111346.44326778395, 115414.0, 116995.0, 117427.41286293599, 117609.41195293968, 9709.980452052432, 10381.11760500366, 10728.409937453358, 10964.28732132409, 11685.415729213506, 14919.850801491846, 14923.0, 14935.178565178801, 14945.925270373797, 14983.475578354706, 9007.63969441228, 9086.591103400362, 9089.727308180765, 9175.632974680939, 9206.493642849708, 9175.44947303164, 9202.355835091614, 9259.768505787275, 9280.489573073412, 9309.115634014757, 3728.8694895678523, 4483.686141970031, 4602.88492787683, 4618.168729628632, 4651.395318608559, 1880.539267879351, 1898.943031709051, 1938.738270333487, 1948.5226119600504, 1959.6668566343756, 818.3698552114838, 916.6516723645105, 1021.7139201023725, 1054.520193312041, 1083.5990683447176, 20426.0, 21324.14703411877, 21473.248436304653, 21629.134834606753, 21656.566868662852, 854.8546747053016, 979.2215188924822, 1005.3917379985004, 1056.3556230699267, 1062.7449412141184, 11290.266132701348, 11401.372924489067, 11421.486033128529, 11544.653660390202, 12306.938465307616, 677667.0, 731662.0, 736996.0, 742961.0, 743307.0, 130944.34527827491, 131507.34246328706, 131948.68051319555, 132333.3383333077, 137489.0, 1116.3357802107732, 1129.1926272715048, 1174.2954227463454, 1197.874223206568, 1200.327816422806, 19432.611347773247, 19894.90052549728, 20168.697469537674, 20543.178272868918, 20595.8970205148, 47729.045419092115, 51832.0, 54339.45660543502, 56683.86632267414, 57013.71493142508, 82900.58549707213, 84925.0, 85710.57144714237, 86830.0, 88657.0, 7802.765917022499, 8008.239217274583, 8366.498010119412, 8763.824723505622, 9012.504312262889, 12978.740425191632, 13779.862201378259, 13884.305784710927, 14067.085639433404, 14271.215083170526, 11325.830112548154, 11683.824742628698, 11720.589779357682, 11906.76186476283, 12147.0, 7887.487313324616, 10917.290376125526, 11489.161734122501, 11845.703857403634, 11935.76128477443, 11364.659060228207, 12100.818487722516, 12104.818427723767, 12154.1492095556, 12357.814632780695, 8320.958395207985, 8379.70671026511, 8422.536760477988, 8682.782930426538, 8830.42602230853, 11493.0, 11967.64097077089, 12026.218295810744, 12207.45066471993, 12300.200486968319], "unit": "score", "name": "jquery.html", "value": 9861.323898983954}, {"lowerIsBetter": false, "replicates": [1344.623505418483, 1442.3797766960206, 1484.9456885611216, 1874.8500119990401, 1973.8847551133608, 8350.248477637011, 9137.588808503617, 9379.671711490098, 9382.01488843671, 9383.953080234589, 8386.329093672506, 8479.576021198945, 8869.246114080312, 9171.037041110687, 9191.264698824094, 2539.5555777738914, 2568.4092658688514, 2570.0362364113457, 2571.9357016074655, 2575.9227223183243, 2203.0, 2491.638712386703, 2526.9639447826394, 2585.340738111788, 2585.9094931677396, 2562.359410147463, 2585.547529182395, 2601.531724289627, 2604.4140068484535, 2608.4783043391303, 2559.78241849443, 2574.781143602796, 2577.445849142434, 2593.2220333899754, 2599.454114635929, 2553.7190908999996, 2581.7547333003336, 2604.270804174834, 2611.229687242268, 2618.3061488705507, 9022.548872556412, 9256.583453744597, 9303.906960930371, 9343.0, 9393.154616084585, 5664.433556644344, 5832.854178645525, 5906.350301466835, 5914.585978981473, 5924.555658325599, 3719.5350581177354, 3821.847126114952, 3853.8265778039777, 3889.3193691104225, 3891.4357418174204, 949.9572519236582, 1067.0609863320306, 1076.983845242322, 1089.5696200001034, 1106.2919731371928, 12442.502299908083, 12621.242725436503, 12659.113862029662, 12695.492180312776, 12703.364831758376, 4864.0, 4882.121218180761, 4890.755462226874, 4919.0, 4961.7271050092595, 9822.0, 9824.017598240262, 9826.65606703762, 9839.016098390246, 9846.359986600848, 5635.126555383922, 5653.858653533613, 5696.917585658712, 5698.088305871041, 5715.342735585377, 4668.50980647034, 4770.522947705202, 5031.245313203049, 5166.3800343958965, 5218.582513398919, 3536.2750636119536, 3567.785932843986, 3876.069743261597, 3912.8043597819997, 3924.1955399143108, 1233.5497543396775, 1238.9442475088642, 1244.564402459132, 1256.2839181666363, 1261.627819793145, 1422.3954819201797, 1449.2246648043456, 1457.4753088887992, 1477.7266205751755, 1481.888858335629, 8716.08481109487, 8720.78198045054, 8749.781255468537, 8776.25401840838, 8795.51624660637, 535.7856857257128, 543.5597166295235, 544.042485226005, 546.0280700353377, 548.3009163316723, 6489.967550162219, 6497.350264973465, 6564.409203171737, 6601.603903765789, 6602.669866506655, 11157.49791259379, 11686.24039437434, 11699.707507312385, 11705.0, 11744.354060526583, 11224.94387528057, 11379.715507112223, 11434.256773309875, 11468.655940321803, 11525.250858694159, 8927.285817134614, 9039.45763254207, 9095.31785116119, 9101.726948191432, 9104.681336153202, 8253.876191857007, 8410.915890841014, 8537.74386768398, 8541.87187192205, 8564.785880353042, 9925.602975880884, 9983.60065597368, 10057.597696092367, 10075.294729368874, 10081.69754907354, 10149.137323327599, 10172.796544069226, 10478.318909270873, 10580.84128738085, 10615.150787936793, 5996.850078748066, 7036.753713619999, 7659.578723170056, 7835.764927052198, 8007.0, 8648.740537783624, 8669.003064647646, 8712.21590056898, 8717.607707653044, 8723.65105395777, 7591.43064270193, 7639.312461878458, 7718.0, 7768.378529717496, 7792.103908050647, 7414.592197429193, 7509.51188172767, 7551.773446796605, 7664.0, 7681.615919203906, 8029.919700803151, 8223.712170074019, 8238.464499807493, 8239.95880020596, 8247.793805154919, 7292.744753933587, 7337.229590892879, 7359.227281135403, 7389.667464964197, 7389.7413590524075, 7493.325600695964, 7507.249275072449, 7556.58438785872, 7558.433117516099, 7577.734779282699], "unit": "score", "name": "mootools.html", "value": 5049.270310537833}, {"lowerIsBetter": false, "replicates": [331.8125259228534, 337.16887871397006, 337.4566947214985, 343.1096305088295, 347.4330768235259, 6675.899861502081, 6728.663566821664, 6756.7635132770365, 6766.323367663231, 6771.492138089645, 6709.563878347916, 6724.0922475465795, 6730.0, 6744.898826517606, 6756.527043106972, 4778.0, 4888.41339039314, 4919.852404427873, 4974.502549745023, 4991.475895031024, 4013.2776100301935, 4955.984023275238, 4989.101961646902, 4996.925046124311, 5008.198688209887, 4931.482194369593, 4936.210206366982, 4941.135301322272, 4946.1838796598695, 4983.177775667011, 4742.383490146276, 4816.229403295456, 4918.188498897677, 4925.236588328815, 4939.876503087452, 4248.214080395106, 4266.31738921771, 4272.807723652443, 4279.679024073176, 4284.250256205183, 6442.355764423567, 6572.76995305162, 6589.275179730226, 6595.208574970986, 6596.769113081067, 5951.375105613892, 5955.702214889281, 5970.761169553212, 5974.581779275452, 5974.61165024272, 6856.142982127234, 7212.0, 7225.349718525358, 7228.783136505913, 7233.855322893565, 4675.649326300541, 4680.625549955996, 4709.411323584552, 4712.387389639359, 4720.858374248778, 6498.610083395011, 7258.455615828834, 7504.474686771928, 7605.6577454014705, 7616.162222155558, 4751.144793937125, 4761.809527618856, 4762.0, 4763.214069678534, 4768.928466073012, 4824.469308376076, 4825.975870120697, 4827.493113223061, 4830.985493046429, 4860.736208585793, 5537.58468114893, 5758.510526605201, 5770.913436298459, 5775.88448231033, 5794.391588883191, 6405.455536279375, 6690.431313338323, 7215.314545118205, 7216.314450127229, 7241.986121942932, 1455.4251070827177, 1528.5949223455793, 1635.3703824027834, 1671.147714665505, 1683.6380178261732, 1013.4426065663855, 1040.5213601743283, 1059.7615536504225, 1064.9254552181428, 1088.542812018938, 6744.258131605519, 6931.549449285781, 6933.341332573397, 6936.722531098801, 6938.41023512997, 7562.470627056164, 7582.62086895664, 7588.62056897153, 7593.544387336778, 7600.581967991813, 6903.965480172567, 6907.033015377851, 6908.6545672716165, 6916.965415172993, 6918.308169183142, 3872.283627528916, 3960.881173564798, 4002.9199416012098, 4011.8194681239415, 4031.7782521960985, 7860.724874629361, 7913.446058775946, 7922.445428819928, 7938.285554300141, 7946.523208607502, 7783.688652453951, 7795.883061754078, 7799.376049916106, 7801.024871891013, 7801.648925798353, 7877.921220787719, 7882.7241046563095, 7886.44794864354, 7886.881696774553, 7895.368370530229, 7242.601656908921, 7481.588512631857, 7511.699532018658, 7512.361449276873, 7548.0, 7318.96340518294, 7373.8156546086775, 7374.889376659462, 7384.0, 7386.556806591621, 7858.292753652198, 7882.448228623941, 7886.408519360956, 7897.210278972057, 7904.170062143622, 4756.571908528249, 4800.7599620019555, 4807.399075115611, 4808.543188397097, 4810.0, 7286.817829554304, 7442.4790264683115, 7498.850022999619, 7506.174320824595, 7514.346843694379, 7232.0959880015, 7251.057362542836, 7262.527935684164, 7266.745663901738, 7277.38142257914, 7146.892796608159, 7236.095488063992, 7280.235575264521, 7291.234420385783, 7301.598412087386, 7100.964495177491, 7104.431645468247, 7112.182099058467, 7124.715011399486, 7124.857502850017, 7020.192677842114, 7247.2390399007345, 7247.8550428990075, 7254.419646428168, 7267.091613548307, 6827.692753826189, 6945.826354341182, 6958.0, 6966.7213311469, 6981.823270412052], "unit": "score", "name": "prototype.html", "value": 5291.723180540099}, {"lowerIsBetter": false, "replicates": [672.1967249137281, 713.7858642407276, 727.9526830756, 731.7512045904391, 805.9758207253781, 15597.0, 15834.28745706443, 15928.920355398206, 15981.760273595877, 15995.360185592563, 14660.340284687189, 14815.259237038132, 14885.479008234714, 14892.702145957075, 15060.472883449082, 969.5394687523441, 969.8254314223437, 982.5283863745407, 982.5774916785779, 984.6110786239431, 816.9754907352789, 829.8423299573092, 973.3332667123008, 999.8250306196422, 1003.002012997069, 932.9813403731921, 1014.8528463372807, 1066.3708412036935, 1070.6787963610925, 1072.104792498265, 842.9199226073513, 1058.4284486377346, 1062.54310646422, 1063.7659714862718, 1066.109798318405, 774.8334108166715, 790.0795573157264, 790.0835031363648, 792.5482474989259, 793.8928244686952, 15675.05949643025, 15699.921500392538, 15725.0, 15749.448769293134, 15750.448734294245, 11305.547778088867, 12904.80642790359, 12993.480260789556, 13046.673833154153, 13195.812376886126, 8350.791230219233, 10417.739556511073, 10524.947375263151, 10621.787564248672, 10956.835647465294, 3624.9093772655633, 3635.63643635637, 3646.6171052039685, 3690.9630903690886, 3769.9623003769884, 92663.53668231616, 93097.53451232768, 94445.52777236138, 94464.0, 94539.99999999932, 9696.854547181798, 9835.96722344158, 9905.702828915, 9952.601895924083, 10167.0, 22368.776312236994, 22610.66084008741, 22624.886875565517, 22625.660615090786, 22785.316440506813, 7653.0816302042995, 7685.308322251024, 7848.332891704269, 7882.211778822072, 7930.206979302024, 4206.07466357407, 4269.978650106729, 4313.61177494027, 4355.15074560464, 4368.060866913629, 3734.8879533614036, 3778.471014058034, 3779.244151169777, 3779.7165212609166, 3781.4516895050065, 572.7565784541553, 668.1981622053555, 681.9727210911508, 682.9180498340131, 685.6732223148224, 622.243973572112, 627.0500192208807, 634.194572892424, 636.6439483899264, 643.7521554201666, 7112.537685050455, 8242.134575869448, 8429.913626299136, 8550.914490855137, 9049.909500905038, 614.923134608174, 635.1711017122607, 641.5156556799586, 644.3170239546096, 680.0, 3951.5060617422823, 3984.322665146932, 4033.8100260423244, 4076.694247931417, 4080.5511393746665, 85529.71705424423, 91912.54043729873, 99446.01107977799, 99579.50210248903, 99614.5019274899, 65595.0321490356, 78071.60964195142, 82544.17455825485, 83018.58490707508, 83956.16043839605, 75290.87063694048, 75357.0, 75482.0, 75909.24090759132, 76602.0, 8543.145685431657, 8597.699080532151, 8703.521306327959, 8756.51839148853, 8951.820963580562, 51702.96594068173, 52136.739316303174, 53011.4698853022, 55671.32986010426, 55768.0, 71997.28002719906, 71998.28001719915, 72259.0, 73651.0, 76551.0, 11355.602553910574, 11374.260673056226, 11655.475503602189, 11697.415129243675, 12038.337891416057, 12025.879741202476, 12128.272303661808, 12225.0, 12310.13829031995, 12396.0, 11825.349605771766, 11959.940200298943, 12001.699957501132, 12058.879411205775, 12178.756424871275, 10098.343607665478, 11639.370488131837, 12394.690132746753, 12443.0, 12448.688782780502, 9246.537673116452, 11912.927836494757, 12048.518059277882, 12115.939420302842, 12143.0, 9874.160696340605, 10119.696409107739, 10144.391336519833, 10153.238507112144, 10246.487675616041, 9937.552810123418, 10059.59214914434, 10059.647912323033, 10071.244656650928, 10133.240006999356], "unit": "score", "name": "yui.html", "value": 7273.145805848563}], "name": "dromaeo_css", "value": 7875.112644162601}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 112.0, 111.0, 119.0, 112.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 191.0, 182.0, 146.0, 139.0, 118.0, 146.0, 148.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [183.0, 183.0, 182.0, 185.0, 182.0, 208.0, 262.0, 197.0, 183.0, 184.0], "unit": "score", "name": "audio-dft", "value": 194.9}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 73.0, 120.0, 55.0, 57.0, 57.0, 57.0, 120.0, 58.0], "unit": "score", "name": "audio-fft", "value": 74.5}, {"lowerIsBetter": true, "replicates": [91.0, 89.0, 131.0, 81.0, 78.0, 80.0, 116.0, 74.0, 80.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 93.8}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 87.0, 84.0, 87.0, 84.0, 88.0, 85.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.9}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 87.0, 86.0, 85.0, 87.0, 83.0, 71.0, 105.0, 135.0], "unit": "score", "name": "imaging-desaturate", "value": 91.2}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 59.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [62.0, 60.0, 69.0, 70.0, 77.0, 73.0, 70.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 80.0, 79.0, 80.0, 80.0, 80.0, 79.0, 81.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.6}, {"lowerIsBetter": true, "replicates": [119.0, 130.0, 135.0, 132.0, 113.0, 121.0, 124.0, 134.0, 130.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.7}, {"lowerIsBetter": true, "replicates": [134.0, 133.0, 137.0, 138.0, 171.0, 158.0, 135.0, 131.0, 134.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.3}, {"lowerIsBetter": true, "replicates": [56.0, 73.0, 94.0, 96.0, 76.0, 67.0, 65.0, 67.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.5}], "name": "kraken", "value": 1437.1000000000001}]} 10:16:04 INFO - Return code: 0 10:16:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:16:04 INFO - # TBPL SUCCESS # 10:16:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:16:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:16:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:16:04 INFO - 2016-05-06 10:16:04.189 screenresolution[2525:23325] starting screenresolution argv=screenresolution get 10:16:04 INFO - 2016-05-06 10:16:04.192 screenresolution[2525:23325] Display 0: 1600x1200x32@60 10:16:04 INFO - 2016-05-06 10:16:04.198 screenresolution[2526:23328] starting screenresolution argv=screenresolution list 10:16:04 INFO - Available Modes on Display 0 10:16:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:16:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:16:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:16:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:16:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:16:04 INFO - Intel Iris: 10:16:04 INFO - Chipset Model: Intel Iris 10:16:04 INFO - Type: GPU 10:16:04 INFO - Bus: Built-In 10:16:04 INFO - VRAM (Dynamic, Max): 1536 MB 10:16:04 INFO - Vendor: Intel (0x8086) 10:16:04 INFO - Device ID: 0x0a2e 10:16:04 INFO - Revision ID: 0x0009 10:16:04 INFO - Displays: 10:16:04 INFO - Display: 10:16:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:16:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:16:04 INFO - Display Serial Number: 1600x1200 60 10:16:04 INFO - Main Display: Yes 10:16:04 INFO - Mirror: Off 10:16:04 INFO - Online: Yes 10:16:04 INFO - Rotation: Supported 10:16:04 INFO - Return code: 0 10:16:04 INFO - Running post-action listener: _resource_record_post_action 10:16:04 INFO - Running post-run listener: _resource_record_post_run 10:16:05 INFO - Total resource usage - Wall time: 1193s; CPU: 52.0%; Read bytes: 323584; Write bytes: 507658752; Read time: 3; Write time: 1739 10:16:05 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 206002688; Write bytes: 207521280; Read time: 18904; Write time: 421 10:16:05 INFO - run-tests - Wall time: 1171s; CPU: 52.0%; Read bytes: 323584; Write bytes: 299138048; Read time: 3; Write time: 1315 10:16:05 INFO - Running post-run listener: _upload_blobber_files 10:16:05 INFO - Blob upload gear active. 10:16:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:16:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:16:05 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:16:05 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:16:05 INFO - (blobuploader) - INFO - Open directory for files ... 10:16:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:16:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:16:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:06 INFO - (blobuploader) - INFO - Done attempting. 10:16:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:16:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:16:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:07 INFO - (blobuploader) - INFO - Done attempting. 10:16:07 INFO - (blobuploader) - INFO - Iteration through files over. 10:16:07 INFO - Return code: 0 10:16:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:16:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:16:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9953b21a07f0b623043e0b2dcbbc68d2c0674cae73625325933968e08e02d6b0b0bcf5aafc04f397e514c8f456e68635d248687a5ed001acd41b27c51129e6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb0fdf14d4ce13afa7c54cbc70f789933972b2a06fcc9f837fb6e6c89d22f7a14ed3ee336391305739c3194332763cc678e023fc98e5a7edea9f11dbb3cd0043"} 10:16:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:16:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:16:07 INFO - Contents: 10:16:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9953b21a07f0b623043e0b2dcbbc68d2c0674cae73625325933968e08e02d6b0b0bcf5aafc04f397e514c8f456e68635d248687a5ed001acd41b27c51129e6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb0fdf14d4ce13afa7c54cbc70f789933972b2a06fcc9f837fb6e6c89d22f7a14ed3ee336391305739c3194332763cc678e023fc98e5a7edea9f11dbb3cd0043"} 10:16:07 INFO - Running post-run listener: copy_logs_to_upload_dir 10:16:07 INFO - Copying logs to upload dir... 10:16:07 INFO - mkdir: /builds/slave/test/build/upload/logs 10:16:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.189261 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-06 10:16:07.743554) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 10:16:07.746976) ========= 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.85hCtLq3aP/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.lw0wKq31Ld/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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-Beta/sha512/e9953b21a07f0b623043e0b2dcbbc68d2c0674cae73625325933968e08e02d6b0b0bcf5aafc04f397e514c8f456e68635d248687a5ed001acd41b27c51129e6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb0fdf14d4ce13afa7c54cbc70f789933972b2a06fcc9f837fb6e6c89d22f7a14ed3ee336391305739c3194332763cc678e023fc98e5a7edea9f11dbb3cd0043"} build_url:https://queue.taskcluster.net/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://queue.taskcluster.net/v1/task/EvBD70rYQrSXJWshmu_y8Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9953b21a07f0b623043e0b2dcbbc68d2c0674cae73625325933968e08e02d6b0b0bcf5aafc04f397e514c8f456e68635d248687a5ed001acd41b27c51129e6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb0fdf14d4ce13afa7c54cbc70f789933972b2a06fcc9f837fb6e6c89d22f7a14ed3ee336391305739c3194332763cc678e023fc98e5a7edea9f11dbb3cd0043"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 10:16:07.774195) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 10:16:07.774532) ========= 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.85hCtLq3aP/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.lw0wKq31Ld/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005355 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 10:16:07.823347) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 10:16:07.823702) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 10:16:07.824021) ========= ========= Total master_lag: 0.15 =========