builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0123 starttime: 1461939214.05 results: success (0) buildid: 20160429061745 builduid: f048a527190b43d78f6b5784399857a0 revision: 3b652d51edf728e672db99d59525f15fc93c4dc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 07:13:34.045671) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 07:13:34.046698) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 07:13:34.046969) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 07:13:34.102748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 07:13:34.103106) ========= 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.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-29 07:13:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 62.9M=0s 2016-04-29 07:13:34 (62.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.602448 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 07:13:34.722403) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 07:13:34.722681) ========= 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.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.019860 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 07:13:34.788397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 07:13:34.788910) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3b652d51edf728e672db99d59525f15fc93c4dc4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3b652d51edf728e672db99d59525f15fc93c4dc4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-29 07:13:34,862 truncating revision to first 12 chars 2016-04-29 07:13:34,862 Setting DEBUG logging. 2016-04-29 07:13:34,862 attempt 1/10 2016-04-29 07:13:34,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3b652d51edf7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 07:13:36,051 unpacking tar archive at: fx-team-3b652d51edf7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.435108 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 07:13:36.244213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 07:13:36.244499) ========= script_repo_revision: 3b652d51edf728e672db99d59525f15fc93c4dc4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 07:13:36.244880) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 07:13:36.248159) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 07:13:36.261987) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 43 secs) (at 2016-04-29 07:13:36.262282) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:13:36 INFO - MultiFileLogger online at 20160429 07:13:36 in /builds/slave/test 07:13:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:13:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:13:36 INFO - {'append_to_log': False, 07:13:36 INFO - 'base_work_dir': '/builds/slave/test', 07:13:36 INFO - 'blob_upload_branch': 'Fx-Team', 07:13:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:13:36 INFO - 'branch': 'Fx-Team', 07:13:36 INFO - 'buildbot_json_path': 'buildprops.json', 07:13:36 INFO - 'config_files': ('talos/mac_config.py',), 07:13:36 INFO - 'default_actions': ('clobber', 07:13:36 INFO - 'read-buildbot-config', 07:13:36 INFO - 'download-and-extract', 07:13:36 INFO - 'populate-webroot', 07:13:36 INFO - 'create-virtualenv', 07:13:36 INFO - 'install', 07:13:36 INFO - 'run-tests'), 07:13:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:13:36 INFO - 'download_minidump_stackwalk': True, 07:13:36 INFO - 'download_symbols': 'ondemand', 07:13:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:13:36 INFO - 'tooltool.py': '/tools/tooltool.py', 07:13:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:13:36 INFO - '/tools/misc-python/virtualenv.py')}, 07:13:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:13:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:13:36 INFO - 'installer_path': 'installer.exe', 07:13:36 INFO - 'log_level': 'info', 07:13:36 INFO - 'log_name': 'talos', 07:13:36 INFO - 'log_to_console': True, 07:13:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:13:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:13:36 INFO - 'opt_config_files': (), 07:13:36 INFO - 'pip_index': False, 07:13:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:13:36 INFO - 'cmd': ('bash', 07:13:36 INFO - '-c', 07:13:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:13:36 INFO - 'enabled': True, 07:13:36 INFO - 'halt_on_failure': False, 07:13:36 INFO - 'name': 'check_screen_resolution'},), 07:13:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:13:36 INFO - 'cmd': ('bash', 07:13:36 INFO - '-c', 07:13:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:13:36 INFO - 'enabled': True, 07:13:36 INFO - 'halt_on_failure': False, 07:13:36 INFO - 'name': 'check_screen_resolution'},), 07:13:36 INFO - 'run_cmd_checks_enabled': True, 07:13:36 INFO - 'sps_profile': False, 07:13:36 INFO - 'sps_profile_interval': 0, 07:13:36 INFO - 'suite': 'dromaeojs', 07:13:36 INFO - 'system_bits': '32', 07:13:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:13:36 INFO - 'title': 't-yosemite-r7-0123', 07:13:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:13:36 INFO - 'use_talos_json': True, 07:13:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:13:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:13:36 INFO - 'work_dir': 'build'} 07:13:36 INFO - ##### 07:13:36 INFO - ##### Running clobber step. 07:13:36 INFO - ##### 07:13:36 INFO - Running pre-action listener: _resource_record_pre_action 07:13:36 INFO - Running main action method: clobber 07:13:36 INFO - rmtree: /builds/slave/test/build 07:13:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:13:37 INFO - Running post-action listener: _resource_record_post_action 07:13:37 INFO - ##### 07:13:37 INFO - ##### Running read-buildbot-config step. 07:13:37 INFO - ##### 07:13:37 INFO - Running pre-action listener: _resource_record_pre_action 07:13:37 INFO - Running main action method: read_buildbot_config 07:13:37 INFO - Using buildbot properties: 07:13:37 INFO - { 07:13:37 INFO - "project": "", 07:13:37 INFO - "product": "firefox", 07:13:37 INFO - "script_repo_revision": "production", 07:13:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:13:37 INFO - "repository": "", 07:13:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:13:37 INFO - "buildid": "20160429061745", 07:13:37 INFO - "pgo_build": "False", 07:13:37 INFO - "basedir": "/builds/slave/test", 07:13:37 INFO - "buildnumber": 794, 07:13:37 INFO - "slavename": "t-yosemite-r7-0123", 07:13:37 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:13:37 INFO - "platform": "yosemite_r7", 07:13:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:13:37 INFO - "branch": "fx-team", 07:13:37 INFO - "repo_path": "integration/fx-team", 07:13:37 INFO - "revision": "3b652d51edf728e672db99d59525f15fc93c4dc4", 07:13:37 INFO - "stage_platform": "macosx64", 07:13:37 INFO - "builduid": "f048a527190b43d78f6b5784399857a0", 07:13:37 INFO - "slavebuilddir": "test" 07:13:37 INFO - } 07:13:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 07:13:37 INFO - Running post-action listener: _resource_record_post_action 07:13:37 INFO - ##### 07:13:37 INFO - ##### Running download-and-extract step. 07:13:37 INFO - ##### 07:13:37 INFO - Running pre-action listener: _resource_record_pre_action 07:13:37 INFO - Running main action method: download_and_extract 07:13:37 INFO - mkdir: /builds/slave/test/build/tests 07:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:37 INFO - https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:13:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 07:13:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 07:13:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 07:13:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 07:13:48 INFO - Downloaded 1199 bytes. 07:13:48 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 07:13:48 INFO - Using the following test package requirements: 07:13:48 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 07:13:48 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:13:48 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 07:13:48 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:13:48 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 07:13:48 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:13:48 INFO - u'jsshell-mac.zip'], 07:13:48 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:13:48 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 07:13:48 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 07:13:48 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:13:48 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 07:13:48 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:13:48 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 07:13:48 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:13:48 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 07:13:48 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:13:48 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 07:13:48 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:13: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')]} 07:13:48 INFO - https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:13:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:13:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:13:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:13:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:13:56 INFO - Downloaded 18124291 bytes. 07:13:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:13:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:13:59 INFO - Return code: 0 07:13:59 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:59 INFO - https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:13:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:13:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:13:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:13:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:14:02 INFO - Downloaded 18124291 bytes. 07:14:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:14:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:14:06 INFO - Return code: 0 07:14: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')]} 07:14:06 INFO - https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:14:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 07:14:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 07:14:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 07:14:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:14:07 INFO - Downloaded 10840145 bytes. 07:14:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:14:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:14:07 INFO - Return code: 0 07:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:07 INFO - https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:14:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:14:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:14:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 07:14:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 07:14:11 INFO - Downloaded 110280174 bytes. 07:14:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:14:11 INFO - mkdir: /builds/slave/test/properties 07:14:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:14:11 INFO - Writing to file /builds/slave/test/properties/build_url 07:14:11 INFO - Contents: 07:14:11 INFO - build_url:https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:14:13 INFO - Running post-action listener: _resource_record_post_action 07:14:13 INFO - Running post-action listener: set_extra_try_arguments 07:14:13 INFO - ##### 07:14:13 INFO - ##### Running populate-webroot step. 07:14:13 INFO - ##### 07:14:13 INFO - Running pre-action listener: _resource_record_pre_action 07:14:13 INFO - Running main action method: populate_webroot 07:14:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:14:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:14:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:14:13 INFO - '--tppagecycles', 07:14:13 INFO - '7'], 07:14:13 INFO - 'tests': ['tsvgm']}}, 07:14:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:14:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:14:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:14:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:14:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:14:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:14:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:13 INFO - 'talos_options': ['--disable-e10s'], 07:14:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:13 INFO - 'talos_options': ['--disable-e10s'], 07:14:13 INFO - 'tests': ['damp', 'tps']}, 07:14:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:13 INFO - 'tests': ['damp', 'tps']}, 07:14:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:14:13 INFO - 'tests': ['dromaeo_dom']}, 07:14:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:14:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:14:13 INFO - 'tests': ['a11yr', 07:14:13 INFO - 'ts_paint', 07:14:13 INFO - 'tpaint', 07:14:13 INFO - 'sessionrestore', 07:14:13 INFO - 'sessionrestore_no_auto_restore', 07:14:13 INFO - 'tabpaint']}, 07:14:13 INFO - 'other-e10s': {'tests': ['a11yr', 07:14:13 INFO - 'ts_paint', 07:14:13 INFO - 'tpaint', 07:14:13 INFO - 'sessionrestore', 07:14:13 INFO - 'sessionrestore_no_auto_restore', 07:14:13 INFO - 'tabpaint']}, 07:14:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:14:13 INFO - 'ts_paint', 07:14:13 INFO - 'tpaint', 07:14:13 INFO - 'sessionrestore', 07:14:13 INFO - 'sessionrestore_no_auto_restore', 07:14:13 INFO - 'tabpaint']}, 07:14:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:14:13 INFO - 'ts_paint', 07:14:13 INFO - 'tpaint', 07:14:13 INFO - 'sessionrestore', 07:14:13 INFO - 'sessionrestore_no_auto_restore', 07:14:13 INFO - 'tabpaint']}, 07:14:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:14:13 INFO - 'tests': ['a11yr', 07:14:13 INFO - 'ts_paint', 07:14:13 INFO - 'tpaint', 07:14:13 INFO - 'sessionrestore', 07:14:13 INFO - 'sessionrestore_no_auto_restore', 07:14:13 INFO - 'tabpaint']}, 07:14:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:14:13 INFO - 'tests': ['a11yr', 07:14:13 INFO - 'ts_paint', 07:14:13 INFO - 'tpaint', 07:14:13 INFO - 'sessionrestore', 07:14:13 INFO - 'sessionrestore_no_auto_restore', 07:14:13 INFO - 'tabpaint']}, 07:14:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:14:13 INFO - 'tests': ['tsvgx', 07:14:13 INFO - 'tsvgr_opacity', 07:14:13 INFO - 'tart', 07:14:13 INFO - 'tscrollx', 07:14:13 INFO - 'cart']}, 07:14:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:14:13 INFO - 'tsvgr_opacity', 07:14:13 INFO - 'tart', 07:14:13 INFO - 'tscrollx', 07:14:13 INFO - 'cart']}, 07:14:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:13 INFO - 'talos_options': ['--disable-e10s'], 07:14:13 INFO - 'tests': ['tp5o']}, 07:14:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:13 INFO - 'tests': ['tp5o']}, 07:14:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:13 INFO - 'talos_options': ['--disable-e10s', 07:14:13 INFO - '--xperf_path', 07:14:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:13 INFO - 'tests': ['tp5n']}, 07:14:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:13 INFO - 'talos_options': ['--xperf_path', 07:14:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:13 INFO - 'tests': ['tp5n']}}, 07:14:13 INFO - 'talos.zip': {'path': '', 07:14:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:14:13 INFO - Running post-action listener: _resource_record_post_action 07:14:13 INFO - ##### 07:14:13 INFO - ##### Running create-virtualenv step. 07:14:13 INFO - ##### 07:14:13 INFO - Running pre-action listener: _resource_record_pre_action 07:14:13 INFO - Running main action method: create_virtualenv 07:14:13 INFO - Creating virtualenv /builds/slave/test/build/venv 07:14:13 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 07:14:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:14:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:14:13 INFO - Using real prefix '/tools/python27' 07:14:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:14:14 INFO - Installing distribute.............................................................................................................................................................................................done. 07:14:16 INFO - Installing pip.................done. 07:14:16 INFO - Return code: 0 07:14:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bde0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd909584810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7fe00>, '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 0x10baa8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7ab20>, '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.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:14:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:14:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QYeEyqL3Gx/Render', 07:14:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:16 INFO - 'HOME': '/Users/cltbld', 07:14:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:16 INFO - 'LOGNAME': 'cltbld', 07:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:16 INFO - 'MOZ_NO_REMOTE': '1', 07:14:16 INFO - 'NO_EM_RESTART': '1', 07:14:16 INFO - 'PAGER': '/bin/cat', 07:14:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:16 INFO - 'PWD': '/builds/slave/test', 07:14:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:16 INFO - 'SHELL': '/bin/bash', 07:14:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmmMVcv0Ve/Listeners', 07:14:16 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:14:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:16 INFO - 'USER': 'cltbld', 07:14:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:16 INFO - 'XPC_FLAGS': '0x0', 07:14:16 INFO - 'XPC_SERVICE_NAME': '0', 07:14:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:14:17 INFO - Cleaning up... 07:14:17 INFO - Return code: 0 07:14:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bde0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd909584810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7fe00>, '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 0x10baa8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7ab20>, '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.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QYeEyqL3Gx/Render', 07:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:17 INFO - 'HOME': '/Users/cltbld', 07:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:17 INFO - 'LOGNAME': 'cltbld', 07:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:17 INFO - 'MOZ_NO_REMOTE': '1', 07:14:17 INFO - 'NO_EM_RESTART': '1', 07:14:17 INFO - 'PAGER': '/bin/cat', 07:14:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:17 INFO - 'PWD': '/builds/slave/test', 07:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:17 INFO - 'SHELL': '/bin/bash', 07:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmmMVcv0Ve/Listeners', 07:14:17 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:17 INFO - 'USER': 'cltbld', 07:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:17 INFO - 'XPC_FLAGS': '0x0', 07:14:17 INFO - 'XPC_SERVICE_NAME': '0', 07:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:17 INFO - Downloading/unpacking psutil>=0.7.1 07:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:14:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:20 INFO - Installing collected packages: psutil 07:14:20 INFO - Running setup.py install for psutil 07:14:20 INFO - building 'psutil._psutil_osx' extension 07:14:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:14:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:14:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:14:20 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 07:14:20 INFO - building 'psutil._psutil_posix' extension 07:14:20 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 07:14:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:14:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:14:20 INFO - ^ 07:14:20 INFO - 1 warning generated. 07:14:20 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 07:14:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:21 INFO - Successfully installed psutil 07:14:21 INFO - Cleaning up... 07:14:21 INFO - Return code: 0 07:14:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bde0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd909584810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7fe00>, '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 0x10baa8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7ab20>, '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.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:14:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QYeEyqL3Gx/Render', 07:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:21 INFO - 'HOME': '/Users/cltbld', 07:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:21 INFO - 'LOGNAME': 'cltbld', 07:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:21 INFO - 'MOZ_NO_REMOTE': '1', 07:14:21 INFO - 'NO_EM_RESTART': '1', 07:14:21 INFO - 'PAGER': '/bin/cat', 07:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:21 INFO - 'PWD': '/builds/slave/test', 07:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:21 INFO - 'SHELL': '/bin/bash', 07:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmmMVcv0Ve/Listeners', 07:14:21 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:21 INFO - 'USER': 'cltbld', 07:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:21 INFO - 'XPC_FLAGS': '0x0', 07:14:21 INFO - 'XPC_SERVICE_NAME': '0', 07:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:14:23 INFO - Installing collected packages: mozsystemmonitor 07:14:23 INFO - Running setup.py install for mozsystemmonitor 07:14:24 INFO - Successfully installed mozsystemmonitor 07:14:24 INFO - Cleaning up... 07:14:24 INFO - Return code: 0 07:14:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bde0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd909584810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7fe00>, '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 0x10baa8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7ab20>, '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.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QYeEyqL3Gx/Render', 07:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:24 INFO - 'HOME': '/Users/cltbld', 07:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:24 INFO - 'LOGNAME': 'cltbld', 07:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:24 INFO - 'MOZ_NO_REMOTE': '1', 07:14:24 INFO - 'NO_EM_RESTART': '1', 07:14:24 INFO - 'PAGER': '/bin/cat', 07:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:24 INFO - 'PWD': '/builds/slave/test', 07:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:24 INFO - 'SHELL': '/bin/bash', 07:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmmMVcv0Ve/Listeners', 07:14:24 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:24 INFO - 'USER': 'cltbld', 07:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:24 INFO - 'XPC_FLAGS': '0x0', 07:14:24 INFO - 'XPC_SERVICE_NAME': '0', 07:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:24 INFO - Downloading/unpacking blobuploader==1.2.4 07:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:26 INFO - Downloading blobuploader-1.2.4.tar.gz 07:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:14:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:14:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:27 INFO - Downloading docopt-0.6.1.tar.gz 07:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:14:28 INFO - Installing collected packages: blobuploader, requests, docopt 07:14:28 INFO - Running setup.py install for blobuploader 07:14:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:14:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:14:28 INFO - Running setup.py install for requests 07:14:28 INFO - Running setup.py install for docopt 07:14:28 INFO - Successfully installed blobuploader requests docopt 07:14:28 INFO - Cleaning up... 07:14:28 INFO - Return code: 0 07:14:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:28 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')]} 07:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:28 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')]} 07:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:28 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 0x10bde0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd909584810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7fe00>, '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 0x10baa8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7ab20>, '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.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:14:28 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 07:14:28 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 07:14:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QYeEyqL3Gx/Render', 07:14:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:28 INFO - 'HOME': '/Users/cltbld', 07:14:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:28 INFO - 'LOGNAME': 'cltbld', 07:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:28 INFO - 'MOZ_NO_REMOTE': '1', 07:14:28 INFO - 'NO_EM_RESTART': '1', 07:14:28 INFO - 'PAGER': '/bin/cat', 07:14:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:28 INFO - 'PWD': '/builds/slave/test', 07:14:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:28 INFO - 'SHELL': '/bin/bash', 07:14:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmmMVcv0Ve/Listeners', 07:14:28 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:14:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:28 INFO - 'USER': 'cltbld', 07:14:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:28 INFO - 'XPC_FLAGS': '0x0', 07:14:28 INFO - 'XPC_SERVICE_NAME': '0', 07:14:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:29 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-uuIGoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:29 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-UqQlK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:29 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-s3R5rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:29 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-4pym7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:29 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-0BfX3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:29 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-OQag0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:29 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-V09lTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:29 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-xguru_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:30 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-XPuoeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:30 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-tJHMYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:30 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-DC0dwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:30 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-AipUfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:30 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-llwtEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:30 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-qo70fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:30 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-HqAS8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:30 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-19TR7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:30 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-5mQW2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:14:30 INFO - Running setup.py install for manifestparser 07:14:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:14:31 INFO - Running setup.py install for mozcrash 07:14:31 INFO - Running setup.py install for mozdebug 07:14:31 INFO - Running setup.py install for mozdevice 07:14:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:14:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:14:31 INFO - Running setup.py install for mozfile 07:14:31 INFO - Running setup.py install for mozhttpd 07:14:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:14:31 INFO - Running setup.py install for mozinfo 07:14:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:14:32 INFO - Running setup.py install for mozInstall 07:14:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:14:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:14:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:14:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:14:32 INFO - Running setup.py install for mozleak 07:14:32 INFO - Running setup.py install for mozlog 07:14:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:14:32 INFO - Running setup.py install for moznetwork 07:14:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:14:32 INFO - Running setup.py install for mozprocess 07:14:32 INFO - Running setup.py install for mozprofile 07:14:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:14:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:14:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:14:32 INFO - Running setup.py install for mozrunner 07:14:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:14:33 INFO - Running setup.py install for mozscreenshot 07:14:33 INFO - Running setup.py install for moztest 07:14:33 INFO - Running setup.py install for mozversion 07:14:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:14:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:14:33 INFO - Cleaning up... 07:14:33 INFO - Return code: 0 07:14:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:33 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 0x10bde0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd909584810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7fe00>, '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 0x10baa8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7ab20>, '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.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:14:33 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 07:14:33 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 07:14:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QYeEyqL3Gx/Render', 07:14:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:33 INFO - 'HOME': '/Users/cltbld', 07:14:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:33 INFO - 'LOGNAME': 'cltbld', 07:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:33 INFO - 'MOZ_NO_REMOTE': '1', 07:14:33 INFO - 'NO_EM_RESTART': '1', 07:14:33 INFO - 'PAGER': '/bin/cat', 07:14:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:33 INFO - 'PWD': '/builds/slave/test', 07:14:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:33 INFO - 'SHELL': '/bin/bash', 07:14:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmmMVcv0Ve/Listeners', 07:14:33 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:14:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:33 INFO - 'USER': 'cltbld', 07:14:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:33 INFO - 'XPC_FLAGS': '0x0', 07:14:33 INFO - 'XPC_SERVICE_NAME': '0', 07:14:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:33 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-i76nE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:33 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)) 07:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:33 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-emuF38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Qnjyvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-2USkns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-xdX8OQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-UsT97X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:34 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)) 07:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-jgBzcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:34 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)) 07:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Op9evg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:34 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)) 07:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-FsI6Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:34 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)) 07:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-BtF8A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:34 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)) 07:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-njsAxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:34 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)) 07:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-zBeUlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-I_auFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-38gcLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-kb37_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-BVpvct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:35 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)) 07:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-r6NBC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:35 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)) 07:14:35 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)) 07:14:35 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)) 07:14:35 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)) 07:14:35 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)) 07:14:35 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)) 07:14:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:14:35 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 07:14:35 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 07:14:35 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 07:14:35 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 07:14:35 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 07:14:35 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 07:14:37 INFO - Downloading blessings-1.6.tar.gz 07:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:14:38 INFO - Installing collected packages: blessings 07:14:38 INFO - Running setup.py install for blessings 07:14:38 INFO - Successfully installed blessings 07:14:38 INFO - Cleaning up... 07:14:38 INFO - Return code: 0 07:14:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:14:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:38 INFO - Reading from file tmpfile_stdout 07:14:38 INFO - Current package versions: 07:14:38 INFO - blessings == 1.6 07:14:38 INFO - blobuploader == 1.2.4 07:14:38 INFO - docopt == 0.6.1 07:14:38 INFO - manifestparser == 1.1 07:14:38 INFO - mozInstall == 1.12 07:14:38 INFO - mozcrash == 0.17 07:14:38 INFO - mozdebug == 0.1 07:14:38 INFO - mozdevice == 0.48 07:14:38 INFO - mozfile == 1.2 07:14:38 INFO - mozhttpd == 0.7 07:14:38 INFO - mozinfo == 0.9 07:14:38 INFO - mozleak == 0.1 07:14:38 INFO - mozlog == 3.1 07:14:38 INFO - moznetwork == 0.27 07:14:38 INFO - mozprocess == 0.22 07:14:38 INFO - mozprofile == 0.28 07:14:38 INFO - mozrunner == 6.11 07:14:38 INFO - mozscreenshot == 0.1 07:14:38 INFO - mozsystemmonitor == 0.0 07:14:38 INFO - moztest == 0.7 07:14:38 INFO - mozversion == 1.4 07:14:38 INFO - psutil == 3.1.1 07:14:38 INFO - requests == 1.2.3 07:14:38 INFO - wsgiref == 0.1.2 07:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:38 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')]} 07:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:38 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')]} 07:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:38 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 0x10bde0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd909584810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7fe00>, '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 0x10baa8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7ab20>, '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.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:14:38 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 07:14:38 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 07:14:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QYeEyqL3Gx/Render', 07:14:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:38 INFO - 'HOME': '/Users/cltbld', 07:14:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:38 INFO - 'LOGNAME': 'cltbld', 07:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:38 INFO - 'MOZ_NO_REMOTE': '1', 07:14:38 INFO - 'NO_EM_RESTART': '1', 07:14:38 INFO - 'PAGER': '/bin/cat', 07:14:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:38 INFO - 'PWD': '/builds/slave/test', 07:14:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:38 INFO - 'SHELL': '/bin/bash', 07:14:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmmMVcv0Ve/Listeners', 07:14:38 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:14:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:38 INFO - 'USER': 'cltbld', 07:14:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:38 INFO - 'XPC_FLAGS': '0x0', 07:14:38 INFO - 'XPC_SERVICE_NAME': '0', 07:14:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:38 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)) 07:14:38 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)) 07:14:38 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)) 07:14:38 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)) 07:14:38 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)) 07:14:38 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)) 07:14:38 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)) 07:14:38 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)) 07:14:38 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)) 07:14:38 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)) 07:14:38 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)) 07:14:38 INFO - Cleaning up... 07:14:38 INFO - Return code: 0 07:14:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:14:38 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')]} 07:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:38 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')]} 07:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:38 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 0x10bde0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd909584810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7fe00>, '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 0x10baa8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7ab20>, '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.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:14:38 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 07:14:38 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 07:14:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QYeEyqL3Gx/Render', 07:14:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:38 INFO - 'HOME': '/Users/cltbld', 07:14:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:38 INFO - 'LOGNAME': 'cltbld', 07:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:38 INFO - 'MOZ_NO_REMOTE': '1', 07:14:38 INFO - 'NO_EM_RESTART': '1', 07:14:38 INFO - 'PAGER': '/bin/cat', 07:14:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:38 INFO - 'PWD': '/builds/slave/test', 07:14:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:38 INFO - 'SHELL': '/bin/bash', 07:14:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmmMVcv0Ve/Listeners', 07:14:38 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:14:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:38 INFO - 'USER': 'cltbld', 07:14:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:38 INFO - 'XPC_FLAGS': '0x0', 07:14:38 INFO - 'XPC_SERVICE_NAME': '0', 07:14:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:39 INFO - Downloading/unpacking jsonschema 07:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:14:41 INFO - Downloading/unpacking functools32 (from jsonschema) 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:41 INFO - Downloading functools32-3.2.3-2.tar.gz 07:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:14:41 INFO - warning: no files found matching '*.txt' 07:14:41 INFO - no previously-included directories found matching 'build' 07:14:41 INFO - no previously-included directories found matching 'dist' 07:14:41 INFO - no previously-included directories found matching '.git*' 07:14:42 INFO - Installing collected packages: jsonschema, functools32 07:14:42 INFO - Running setup.py install for functools32 07:14:42 INFO - warning: no files found matching '*.txt' 07:14:42 INFO - no previously-included directories found matching 'build' 07:14:42 INFO - no previously-included directories found matching 'dist' 07:14:42 INFO - no previously-included directories found matching '.git*' 07:14:42 INFO - Successfully installed jsonschema functools32 07:14:42 INFO - Cleaning up... 07:14:42 INFO - Return code: 0 07:14:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:42 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 0x10bde0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd909584810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7fe00>, '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 0x10baa8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7ab20>, '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.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:14:42 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 07:14:42 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 07:14:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QYeEyqL3Gx/Render', 07:14:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:42 INFO - 'HOME': '/Users/cltbld', 07:14:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:42 INFO - 'LOGNAME': 'cltbld', 07:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:42 INFO - 'MOZ_NO_REMOTE': '1', 07:14:42 INFO - 'NO_EM_RESTART': '1', 07:14:42 INFO - 'PAGER': '/bin/cat', 07:14:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:42 INFO - 'PWD': '/builds/slave/test', 07:14:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:42 INFO - 'SHELL': '/bin/bash', 07:14:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmmMVcv0Ve/Listeners', 07:14:42 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:14:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:42 INFO - 'USER': 'cltbld', 07:14:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:42 INFO - 'XPC_FLAGS': '0x0', 07:14:42 INFO - 'XPC_SERVICE_NAME': '0', 07:14:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:42 INFO - Downloading/unpacking flake8 07:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:14:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:14:44 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 07:14:44 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 07:14:44 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 07:14:44 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 07:14:44 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 07:14:44 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 07:14:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:14:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:14:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:14:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:14:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:14:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:14:46 INFO - no previously-included directories found matching 'docs/_build' 07:14:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:14:46 INFO - Running setup.py install for pep8 07:14:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:14:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:14:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:14:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:14:46 INFO - no previously-included directories found matching 'docs/_build' 07:14:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:14:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:14:46 INFO - Cleaning up... 07:14:46 INFO - Return code: 0 07:14:46 INFO - Running post-action listener: _resource_record_post_action 07:14:46 INFO - Running post-action listener: _start_resource_monitoring 07:14:46 INFO - Starting resource monitoring. 07:14:46 INFO - ##### 07:14:46 INFO - ##### Running install step. 07:14:46 INFO - ##### 07:14:46 INFO - Running pre-action listener: _resource_record_pre_action 07:14:46 INFO - Running main action method: install 07:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:46 INFO - Reading from file tmpfile_stdout 07:14:46 INFO - Detecting whether we're running mozinstall >=1.0... 07:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:14:46 INFO - Reading from file tmpfile_stdout 07:14:46 INFO - Output received: 07:14:46 INFO - Usage: mozinstall [options] installer 07:14:46 INFO - Options: 07:14:46 INFO - -h, --help show this help message and exit 07:14:46 INFO - -d DEST, --destination=DEST 07:14:46 INFO - Directory to install application into. [default: 07:14:46 INFO - "/builds/slave/test"] 07:14:46 INFO - --app=APP Application being installed. [default: firefox] 07:14:46 INFO - mkdir: /builds/slave/test/build/application 07:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:15:20 INFO - Reading from file tmpfile_stdout 07:15:20 INFO - Output received: 07:15:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:15:20 INFO - Running post-action listener: _resource_record_post_action 07:15:20 INFO - ##### 07:15:20 INFO - ##### Running run-tests step. 07:15:20 INFO - ##### 07:15:20 INFO - Running pre-action listener: _resource_record_pre_action 07:15:20 INFO - Running main action method: run_tests 07:15:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:15:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:15:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:15:20 INFO - 2016-04-29 07:15:20.353 screenresolution[1972:28365] starting screenresolution argv=screenresolution get 07:15:20 INFO - 2016-04-29 07:15:20.356 screenresolution[1972:28365] Display 0: 1600x1200x32@60 07:15:20 INFO - 2016-04-29 07:15:20.361 screenresolution[1973:28367] starting screenresolution argv=screenresolution list 07:15:20 INFO - Available Modes on Display 0 07:15:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:15:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:15:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:15:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:15:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:15:20 INFO - Intel Iris: 07:15:20 INFO - Chipset Model: Intel Iris 07:15:20 INFO - Type: GPU 07:15:20 INFO - Bus: Built-In 07:15:20 INFO - VRAM (Dynamic, Max): 1536 MB 07:15:20 INFO - Vendor: Intel (0x8086) 07:15:20 INFO - Device ID: 0x0a2e 07:15:20 INFO - Revision ID: 0x0009 07:15:20 INFO - Displays: 07:15:20 INFO - Display: 07:15:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:15:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:15:20 INFO - Display Serial Number: 1600x1200 60 07:15:20 INFO - Main Display: Yes 07:15:20 INFO - Mirror: Off 07:15:20 INFO - Online: Yes 07:15:20 INFO - Rotation: Supported 07:15:20 INFO - Return code: 0 07:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:15:20 INFO - Python 2.7.3 07:15:20 INFO - Return code: 0 07:15:20 INFO - grabbing minidump binary from tooltool 07:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7fe00>, '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 0x10baa8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:15:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:15:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:15:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:15:20 INFO - Return code: 0 07:15:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:15:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:15:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:15:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:15:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:15:21 INFO - Return code: 0 07:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--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 07:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0123 --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 07:15:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QYeEyqL3Gx/Render', 07:15:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:21 INFO - 'HOME': '/Users/cltbld', 07:15:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:21 INFO - 'LOGNAME': 'cltbld', 07:15:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:15:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:21 INFO - 'MOZ_NO_REMOTE': '1', 07:15:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:15:21 INFO - 'NO_EM_RESTART': '1', 07:15:21 INFO - 'PAGER': '/bin/cat', 07:15:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:21 INFO - 'PWD': '/builds/slave/test', 07:15:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:15:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:21 INFO - 'SHELL': '/bin/bash', 07:15:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmmMVcv0Ve/Listeners', 07:15:21 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:15:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:21 INFO - 'USER': 'cltbld', 07:15:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:21 INFO - 'XPC_FLAGS': '0x0', 07:15:21 INFO - 'XPC_SERVICE_NAME': '0', 07:15:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--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 07:15:21 INFO - mozversion application_buildid: 20160429061745 07:15:21 INFO - mozversion application_changeset: 3b652d51edf728e672db99d59525f15fc93c4dc4 07:15:21 INFO - mozversion application_display_name: Nightly 07:15:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:15:21 INFO - mozversion application_name: Firefox 07:15:21 INFO - mozversion application_remotingname: firefox 07:15:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:15:21 INFO - mozversion application_vendor: Mozilla 07:15:21 INFO - mozversion application_version: 49.0a1 07:15:21 INFO - mozversion platform_buildid: 20160429061745 07:15:21 INFO - mozversion platform_changeset: 3b652d51edf728e672db99d59525f15fc93c4dc4 07:15:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:15:21 INFO - mozversion platform_version: 49.0a1 07:15:21 INFO - using testdate: 1461939321 07:15:21 INFO - actual date: 1461939321 07:15:21 INFO - starting webserver on 'localhost:52677' 07:15:21 INFO - SUITE-START | Running 2 tests 07:15:21 INFO - TEST-START | dromaeo_css 07:15:21 INFO - operating with platform_type : mac_ 07:15:21 INFO - Initialising browser for dromaeo_css test... 07:15:21 INFO - TEST-INFO | started process 1991 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpjubLdy/profile http://localhost:52677/getInfo.html) 07:15:24 INFO - PROCESS | 1991 | __metrics Screen width/height:1600/1200 07:15:24 INFO - PROCESS | 1991 | colorDepth:24 07:15:24 INFO - PROCESS | 1991 | Browser inner width/height: 1024/689 07:15:24 INFO - PROCESS | 1991 | __metrics 07:15:24 INFO - PROCESS | 1991 | 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" 07:15:24 ERROR - PROCESS | 1991 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:15:25 INFO - TEST-INFO | 1991: exit 0 07:15:25 INFO - Browser initialized. 07:15:25 INFO - Running cycle 1/1 for dromaeo_css test... 07:15:25 INFO - TEST-INFO | started process 1993 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpjubLdy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:37 INFO - PROCESS | 1993 | RSS: Main: 239296512 07:15:37 INFO - PROCESS | 1993 | 07:16:28 INFO - PROCESS | 1993 | 1461939388408 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] 07:18:38 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:52677/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52677/tests/dromaeo/cssquery-ext.html) 07:18:40 INFO - PROCESS | 1993 | RSS: Main: 359350272 07:18:40 INFO - PROCESS | 1993 | 07:21:42 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:52677/tests/dromaeo/cssquery-ext.html (next: http://localhost:52677/tests/dromaeo/cssquery-jquery.html) 07:21:43 INFO - PROCESS | 1993 | RSS: Main: 371175424 07:21:43 INFO - PROCESS | 1993 | 07:24:45 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:52677/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52677/tests/dromaeo/cssquery-mootools.html) 07:24:46 INFO - PROCESS | 1993 | RSS: Main: 369725440 07:24:46 INFO - PROCESS | 1993 | 07:27:48 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:52677/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52677/tests/dromaeo/cssquery-prototype.html) 07:27:49 INFO - PROCESS | 1993 | RSS: Main: 365588480 07:27:49 INFO - PROCESS | 1993 | 07:30:52 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:52677/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52677/tests/dromaeo/cssquery-yui.html) 07:30:53 INFO - PROCESS | 1993 | RSS: Main: 337989632 07:30:53 INFO - PROCESS | 1993 | 07:33:55 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:52677/tests/dromaeo/cssquery-yui.html (next: http://localhost:52677/tests/dromaeo/cssquery-dojo.html) 07:33:56 INFO - PROCESS | 1993 | RSS: Main: 373100544 07:33:56 INFO - PROCESS | 1993 | 07:33:56 INFO - PROCESS | 1993 | __start_tp_report 07:33:56 INFO - PROCESS | 1993 | _x_x_mozilla_page_load 07:33:56 INFO - PROCESS | 1993 | _x_x_mozilla_page_load_details 07:33:56 INFO - PROCESS | 1993 | |i|pagename|runs| 07:33:56 INFO - PROCESS | 1993 | |0;dojo.html;3335.7498187635924;3369.7809642373245;3377.9831100844485;3404.0468668772724;3445.983434886708;4451.265541185709;5429.294191755066;5552.4169962154;5572.721363931808;5615.466530679589;4517.616002639771;5619.606627536064;5688.402717714643;5695.174199741045;5728.42715728427;5061.367329083864;5099.821506247282;5122.564582010515;5149.510796474347;5243.475652434745;5210.983858147643;5254.211868219779;5263.631545791796;5267.1309233976535;5287.41838397776;4102.979485102585;5065.088284108859;5079.31429257053;5100.336956195708;5194.818181363653;5140.228965655144;5160.664556803796;5167.431582525919;5169.043726910533;5251.238570407269;5104.081265372231;5114.948850511484;5127.8205262816;5157.5616072633875;5226.3989641191365;5439.075357189287;5532.7786888524415;5546.500814926676;5553.111502159635;5555.583331250132;6055.130578955452;6143.508519318444;6167.537434692416;6169.475594574466;6185.35053819347;6180.103884936659;6203.534734894856;6245.656488893109;6255.280642726054;6267.1539342189135;5264.684118952875;5466.753996070186;5578.665280083208;5722.713864306809;5798.565107616903;5169.922451163236;6257;6257.7184026718905;6271.717772700239;6277.748890044439;5595.888082238333;6040.697965101727;6050.21347224858;6069.635821850703;6094.360092190344;5509.972450137804;5967.92577336075;6066.211392518944;6123.374132580074;6150.138980542728;6072.848178795565;6091.8690759028295;6131.9272270139245;6146.416090471398;6149.86227547905;6181.350958149419;6197.4732147767045;6201.0388389799655;6202.844928876814;6211.81364559064;4792.880177995578;4875.731834749052;4878.829240976549;4887.29134275528;4921.8523444296725;3956.3867600521967;4166.208420400114;4224.66202703783;4234.1108367242605;4369.388285640013;5538.972305138448;5543.113101903676;5543.7782488700805;5545.3622833374675;5583.3858275589655;4809.639277054235;6133.478654314344;6138.14066030756;6163.7842675506145;6182.258129024456;5511.476409741068;5554.028045092174;5579.776808927679;5583.916241256385;5617.606767526234;5292.100342941709;5296.232046353257;5300.416954135042;5314.7608357624;5315.73421328932;6163.537734670007;6176.320604733565;6271.247450305901;6275.529335299871;6279.874402511924;6216.409441103088;6253.37466253371;6256.843578910563;6267;6271.184745982993;6276.686165691788;6281.026440901667;6287.497000239879;6291.716872740829;6302.936970630419;5116.411612664591;5915.142304365929;6047.758089676364;6112.938870611237;6132.5400594956445;5266.657667251617;5844.26946631671;6153.84615384619;6163.291221509584;6220.657863817533;5965.70171491415;6006.519478441627;6014.759409623566;6021.157038014594;6029.246344206974;5772.7690892363835;5959.22530071088;5973.104034394875;5974.1934838796205;5977.073553599199;5744.569157313134;5816.418358164319;5824.592278540462;5837.766489340379;5855.38518455556;5902.2622172228475;5915.881682366415;5945.19739835134;5952.375000625046;6008.188894499362;5732.828015159552;5735.971320143372;5778.27771528559;5794.855128621818;5807.390224026416 07:33:56 INFO - PROCESS | 1993 | |1;ext.html;500.69707826764807;525.0103554799202;533.4425525326034;536.7316341829086;575.5194412665422;27955.580666289996;31287.530687039685;38357.80821095894;39424.40863387052;39546;41867.790661046725;42604.78697606515;42610.57389426105;42682.78658606703;42756.57243427565;9364.39131456455;9558.283128765335;9562.330636855422;9581.904180958205;9606.519674016306;9401.62393504259;9549.570269337897;9550.570224339921;9560.13958743713;9564.904350956505;9595.040495950385;9652.420854748703;9654.662086826962;9673.516324183798;9681.75795605112;9510.239180865514;9576;9576.425414475154;9583.808323833555;9594.760130996747;9474.763130921714;9600.759981000461;9620.182284505825;9621.278404119648;9625.085616866387;39843.20313593712;40098.39852402217;40112;40117.59882401197;40119.799401002805;3167.224030112637;3187.2828613561996;3197.6802319767835;3207.1501052220947;3364.680355366236;28762;29058.41883162325;29203.70796292031;29318.120456386343;29388.559171612444;2689.9865500672568;2717.9320516987036;2780.5829125631117;2802.8598570071413;2861.399106187703;431931;433075;433663.83168084273;435273.6490033442;436748;58833.70583147057;59645.10532342018;59670;59715.70142149348;59765.70117149386;62156.378436215964;63535;63559.682201588694;63628;63635;14159.221242831538;17220.397286094925;17248.827511724972;17297.56756081083;17328.39350622722;13006.739865202831;13038.674033149247;13055;13056.673583160496;13085.476580936656;19448.319308824408;19661;19671.60656786885;19685.01574921248;19700;7910.920890791133;7973.441859069925;7999.840083156726;8002.719225020841;8049.55727434985;913.8949020862553;968.719071469266;986.8569057486624;1035.2649618770756;1088.646189988241;26342;29321.853390733337;29567.852160739058;29976.95080672166;30035.098947031624;926.8470702334039;1084.6691759013577;1120.7814476177068;1187.1986409173946;1205.9155859089778;15194.088354698753;15196.392144314104;15257.847421525865;15556.377744890304;15647.452339168301;466578;468987;470884;473086;663864;57472.71263643655;57589.712051440314;58353.416465835646;58388;58444.70777646085;1347.93934272956;1356.3082827757717;1476.2397365356849;1478.8669019788272;1487.0334282716105;21920.89039554792;22669.773302267426;22897.00410715267;28993;29607;54770.452295476534;55397.72301138468;55706.44293557013;55820;56026.43973560212;549984;553553;553959;554808;554988;26974.595381068906;27453.666438352164;38584.42123368096;40130;40312.19375612413;42079.7896010518;42892;42972.14055718805;43654;44282;30781.846090769403;34585.962421127406;34642.65357346495;36531.63468365389;36668.44997325096;28449.004284849932;34754.30491390209;34903.476447852794;35413;35415.82292088523;36178.8191059043;36747.26505469822;36840.44739328966;37258.62741372552;37518.812405937795;30394.392112158075;31203.84398077995;32183.176659490942;32259.677403226608;32284.83857580697;19581.608367832847;23953.16163934254;24318.784060796537;24395.4991620785;24541.509169816145 07:33:56 INFO - PROCESS | 1993 | |2;jquery.html;398.60338962732084;400.67945643485206;401.752921952999;403.1714826032503;411.2022676008543;12619.495220191204;18557.907210463964;20171.09230084646;21035.894820525915;21083.26208582698;16944.745828812578;17207.397741079065;19695.015249237553;20523.589528209428;21015.894920525414;5286.471352864712;6028.819135425944;6069.544784141207;6077.78727744529;6090.147379366892;5697.544196464273;5914.378990206031;6013.1581578579035;6021.638701677914;6026.427489388501;5941.316748573904;5964.2246507953905;5970.582059255854;5978.22283103196;5980.342162362137;5674.546036317085;5963.761449542013;5999.070144127667;6013.458788709037;6031.427014433643;5242.135047717122;5245.842624721265;5267.578593712532;5271.499207575274;5280.577553795687;21229.681554776536;24112.63831042536;25444.236672899842;26601.46797064067;27267.045653402034;2073.409078412645;2186.9234576789736;2193.1994821890053;2320.2691152287143;2407.1574948767966;15052.774208386883;15472.690546189013;15527.223638818014;15782.210889455482;15812.97215680977;1738.4176300939075;1756.7891852977596;1801.351513455155;1838.7793464784177;1934.5937353155855;91057.63413548803;123144.38427807804;124239.75760242462;125437;127561.36219318937;11064.834027489595;11314.490847911864;11547.249428787101;11562.190646654823;11741.119416043832;12069.215500992408;14513.854861451462;14622.122672639676;14660.706785864437;14676.339564719614;7189.92810071903;7773.833924911309;8775.517346546001;8905.643774248958;8987.146221108984;8845.469271843709;8852.557372131369;8855.867161992575;8993.685221017233;9001.18989290967;6602.669866506655;6770.627615481196;6793.762218322335;6794.558353706993;6798.320167983261;1870.5417172792752;1901.7052356884706;1902.876313039648;1910.4555201767707;1918.1176658737138;945.6831961293044;956.2302346611045;984.5963155106372;1007.3351587951917;1031.2626472072504;20741.28353154346;21071.68392474114;21272.468188295108;21450.463738406354;21500.677489837664;809.3242142810819;980.2109302011949;1004.5278719002057;1018.7147598672384;1073.63496411219;9026.916769987512;9803.411795292306;11005;11254.324740515594;11518.078553715683;555021;579184;593910;608372;612597;123114;125984;127693;127720;128185.35907320591;1036.171252480732;1056.3872953686844;1062.1290541755686;1070.2454769387564;1078.191356482638;18727.96996165224;18914.51292246521;19031.809681903003;19052.856828590327;19071.90464047671;36855.63144368522;37877.62122378851;48268.55194344175;48970;50078.74960625319;59392.109118364126;61011;61749;62312;62659;7598.962005189938;7924.366050716044;8002;8064.193580641889;8188.590570471333;12138.271703697454;12209.877901220874;12487.375631218221;12549.247045177319;12675.556355527513;10584.259101862795;10673.306235094695;10816.729581760204;11198.664040078811;11211.551537938718;10385;10530.104581175461;10664.786704265716;10699.251052426567;10826.56693732242;9244;10729.980651838063;11115.72210694739;11288.209825312479;11365;7784.065912090586;7980.521168729895;8133;8161.102278749451;8222.62998165096;10666.466676665981;10686.689961093536;10905.097099495908;11017.559297628326;11079.169062320198 07:33:56 INFO - PROCESS | 1993 | |3;mootools.html;1418.999605278279;1484.1169504145034;1580.138824340734;1787.7229029500425;1947.133525581117;7793.766187014385;8623.094575069621;8869.02440731519;8874.733757987255;8878.15657512536;8509.702160424386;8732.563371831415;8749.168828961254;8753.474791512514;8770.517621530813;2415.0581273303424;2447.412620970972;2447.840890342131;2449.130558651671;2449.510097980402;2399.734573311743;2441.2310122311414;2447.865367404792;2449.6570480132796;2450.8652024138664;2420.7095148582107;2433.902643894251;2449.2040086971715;2450.2281781238944;2450.82844200906;2389.7968672662846;2415.287490190398;2422.7577242275806;2427.9635805462844;2432.6107822748277;2014.2647933504165;2376.358383236534;2412.5657381671294;2414.0947144820693;2421.6609674645565;8505.234528892368;8703.129687031309;8760.8685869712;8770.210681038738;8778.341624378134;5170.224466330043;5378.704171270579;5388.515033646991;5412.512873841334;5419.024575576394;3474.1662001119803;3547.6984456321243;3643.2895585360866;3643.3806252937065;3666.834992425347;873.860182370824;1045.2369770067894;1045.7594753206804;1057.6615483045427;1058.1217589400856;11061.778764424747;11529.365884876328;11535.365554894477;11536.96167344943;11551.884481155164;4813.542713442217;4836.540528649843;4883.169861123618;4935.087008903364;4964.900701986012;10075;10096.848547271797;10098.899011009942;10103.84844227337;10107.39355638664;5369.328833895763;5432.483914028161;5459;5471.562275017989;5476.972615136899;4393.494748103945;4586;4814;4906.582940450102;4922.852314430573;3807.4098514730263;3925.5878132796215;3962.841486340572;4096.426500289962;4131.421600975866;1152.4410660829492;1328.167129361475;1351.3175846197607;1355.1801160298076;1368.746781845342;651.2510612795229;774.9147593764682;868.1708967935606;886.827068721606;936.0732874454377;5475.233467314579;5721.199032135504;5775.191473193756;5825.33008703996;6004.639721616717;493.77286448233497;498.14568015852984;502.2546650389866;510.6246908522233;661.4741280681869;3860.0735823402183;3975.284448799244;4034.435179074932;4051.6961227908023;4058.1680755445063;6957.478189135733;10274.486275686186;10693.625723099654;10699.358038517557;10699.679009629723;10627.52176152075;10647;10749.570017199225;10765.78468430627;10792.46037698112;7669.578173200416;8015.7595272141925;8071.4349995500925;8108.797280067927;8256.215659512336;5838.1826544282985;5952.107183922446;5976.671283079472;6036.607620504828;6059.242594675666;9402.43585384879;9863.852042219229;9864.950675246579;9870.062344077302;9887.406755594688;9575;9651.662191823252;9745.853812192965;9750.219982401533;9936.701898943043;7356.96321518389;7625;7637.6563054661565;7638.083429988437;7643.617819109134;8008.599570021592;8049.074356449083;8150.192714161382;8238.464499807493;8254.711085111992;7319.707211711472;7335.633218339169;7384.815379615553;7499.925000749922;7509.812254693677;7158;7281.235470275757;7312.9396237546325;7348;7443.962780186281;6628.966855165693;6943.722251109899;7003.894941575779;7010.193827709674;7024.719011239493;4830.2513110467935;4840.7337596432535;4921.68009079423;4945.208766597327;4953.356063711694;4148.481439820022;4853.174960256694;4920.92618610714;4944.6785958914;5152 07:33:56 INFO - PROCESS | 1993 | |4;prototype.html;318.60174781523096;319.0190165241882;326.9722073623741;329.3446042375672;332.51784911877786;4341.351775416997;4421.270490369086;5137.794488220471;5272.340957380323;5298.4966428189355;3929.2927273090904;4928.275103713708;5210.7655155518;5238.423773384925;5282.072043704049;3375.611804642461;3643.234920666663;3877.2827026999953;3996.8800935971967;4035.7982100894983;3472.461768425898;3892.9026774330587;4089.7670910607526;4095.6518695910736;4143.19207754488;4067.776272305022;4071.42999980003;4110.979445102786;4117.9176416471655;4134.917301653965;3881.7485858202176;3914.53025636924;4090.550039495653;4101.323281658522;4158;3369.393509168349;3587.856485740567;3593.1196856770257;3605.9278814423565;3610.332088563624;5099.745012749348;5118.59051275897;5130.897382052375;5142.434332223453;5144.691318520863;4231.91536169278;4468.463784345867;4473.351364052227;4589.5639914208095;4621.930671039937;4786.7845946932475;4836.250381190921;5477.4796394342475;5482.205080263379;5500.80747173847;3900.278448487039;3907.159960608483;3924.2543916655745;3925.8429662813455;3952.920941581181;4994.07609592223;5183.974080129575;5770.567207459458;5803.95528804815;5825.504832089235;3871.0515923598336;3953.881383558498;3971;3983.1237127831832;3985.9003524911527;3696.722745794076;4003.979980100081;4023.8390464381096;4063.6952228582973;4065.4105154752397;4135.697255364551;4168.478940132483;4270.658347332268;4647.350190682259;4648.953510464919;5588.469095435927;5608.495235428831;5624.971875140598;5638.887222255532;5642.294713160855;1280.2702459598127;1387.882030027459;1427.4076258352875;1439.5897169306697;1445.9566213013627;836.3016880904391;895.5029958373035;908.5502676175336;951.7620594851287;966.4829316315737;4987.251912213124;5113.446154922368;5253.605979551549;5275.366955965309;5704.201411802351;6254.499640028786;6260;6282.465990390777;6305.054241863665;6323.5889667172405;5429.56563474921;5616.297962754656;5646.265985421869;5671.2060311556415;5729.684867332337;2781.2629653141935;3070.8618112185004;3083.892063777802;3226.3547290541514;3268.313654132611;5435.728213589305;5639.943600564024;6245.968770156211;6449.774257900951;6499.512536559777;6349.206349206349;6381.010943303795;6384.968075159687;6389.233292004989;6394.968025159845;6446.355364463516;6447.806565803034;6454.225088100716;6457.709403076873;6505.146033380463;4573.993721381291;5806.983777838946;6096.512279017579;6209.223847019122;6226.377362263737;5634;6064.575479716377;6131.325554189125;6137.938620613737;6165.660888651168;5370.436104209158;6156.199694039746;6402.135711678864;6438.581492202992;6469.732784943573;4127.009517715786;4157.10622216225;4160.271952408377;4164.521080075709;4169.45797046382;5706.343770466449;6208.534359922934;6209.410106039919;6215.378462153749;6215.751369945152;5636.013697602985;5880.353161152184;5946.405359464019;6013.939860601338;6033.87932241344;5274.762635681327;5666.688332141772;6017.669028203491;6025.487833534199;6039.154518367344;4910.680805747615;4960.668485811662;4998.525140111684;5371.758270877742;5934.258217722785;4473.530279320755;5192;5533;5608.663480191201;5623.0721930880945;4594.816207351669;4654.6741728078705;5460.914583260445;5497.642653227527;5498.635586697758 07:33:56 INFO - PROCESS | 1993 | |5;yui.html;647.5370110371084;660.8480049588594;710.7121615745625;749.8612756640018;752.9247075292471;14457.204853733041;14895.553133405989;14937.551873443786;14943.551693449186;14951.47669831556;12323;13522;13759.93120034401;13778.655533611665;13933.651658708537;921.7925966657499;926.8609708543705;933.0809152984305;935.7847695030147;937.2127412973101;932.6828878181417;933.8412469880137;938.1884669760676;939.5959737312953;939.8590211468301;977.2524019125375;981.6220755009301;982.3172894838091;983.7884854756226;986.2208855004537;975.3270243531975;978.1685567267837;979.4417182206074;979.8726165598426;980.0003995924153;723.4935545118385;724.4132252875188;725.8548290341953;726.6330503095903;727.2690945599692;11877.287362758263;12071.637850864488;12088;12095.274283542927;12103.334316612583;11202.43987800615;11256.38089905055;11311.717207069807;11531.942340288246;11693.824592631117;9231.769205769842;9346.906530934739;9459.952700236523;9530.904690953072;9989.650362237287;3355.1276668066234;3453.188500702333;3460.602030766469;3518.1908161123083;3526.806025668613;52897.7355113222;70595.64702176457;78737.60631196808;79294;79551.60224198842;9594.712158635251;9631.71104866855;9663.46850923192;9768.316217864682;9913.504324783731;21809.67285490719;21812.345629631138;21848.781512184993;21855.45361365947;21879.45301367447;7390.150132734697;7489.440456112599;7518.436117291225;7559.848803023909;7668.348190403766;4049.169920166418;4114.280000999813;4114.629683328455;4115.238680844053;4125.876223713293;3569.5538057742783;3647.3434781739543;3653.725970552219;3655.049687081378;3656.597774244831;639.4277121975806;658.7661380210052;659.7789740436912;662.1127688896901;666.7166454256921;487.91461494238365;542.9782808687609;564.8305508347479;603.4380086545729;609.2171559546051;7981.640826162837;8268.049174344907;8273.296769774637;8387.706430275033;8554.486730796172;532.5127508329834;579.8202557207279;584.0596639410545;589.6108568344872;608.3399511529951;3871.709621778378;3877.709171812069;3920.862769803043;3982.064214909494;3991.7006224532697;86731.56634216914;91593.62609560862;91714;93030.53484732668;95759.0437993892;82195.17804821995;82485;82808;83071.5846420764;83202.58398708088;57394;72745.63627181831;73232.90150647744;73571;74063;7628.771136865903;7733.535987840747;7856.489328193649;7882.566458844819;8014.488342970395;41619.37570936499;43493.34759978666;43532.56467435285;43614.345784813886;44322.335164971904;63346.04980925198;63900;64014.719705606556;64017;64165.67917160384;10134.23993200498;10316;10353.4305613192;10445.582176712845;10596.417197054236;9159.679411220575;11251.831222531833;11271.774564508827;11297.830532542182;11312.03847672957;10296.691099267035;10357;10362.585496580354;10636;10695.94652026735;10212.438315892698;10305.896941030494;10325.122364599094;10385.117265032557;10665.514604375703;10408.687739367831;10481.79036419252;10482.161427085968;10701.946490267499;10782.029617334478;8925;8939.821203576023;9204.171624553823;9221.49281789508;9327;7542.434317426325;8789;8881.822363552563;8911.55442227899;9124.361294709306 07:33:56 INFO - PROCESS | 1993 | __end_tp_report 07:33:56 INFO - PROCESS | 1993 | __start_cc_report 07:33:56 INFO - PROCESS | 1993 | _x_x_mozilla_cycle_collect,1326 07:33:56 INFO - PROCESS | 1993 | __end_cc_report 07:33:56 INFO - PROCESS | 1993 | __startTimestamp1461940436070__endTimestamp 07:33:56 INFO - PROCESS | 1993 | 07:33:56 INFO - PROCESS | 1993 | ------- Summary: start ------- 07:33:56 INFO - PROCESS | 1993 | Number of tests: 6 07:33:56 INFO - PROCESS | 1993 | 07:33:56 INFO - PROCESS | 1993 | [#0] dojo.html Cycles:165 Average:5604.81 Median:5744.57 stddev:656.57 (11.4%) stddev-sans-first:634.00 07:33:56 INFO - PROCESS | 1993 | Values: 3335.7 3369.8 3378.0 3404.0 3446.0 4451.3 5429.3 5552.4 5572.7 5615.5 4517.6 5619.6 5688.4 5695.2 5728.4 5061.4 5099.8 5122.6 5149.5 5243.5 5211.0 5254.2 5263.6 5267.1 5287.4 4103.0 5065.1 5079.3 5100.3 5194.8 5140.2 5160.7 5167.4 5169.0 5251.2 5104.1 5114.9 5127.8 5157.6 5226.4 5439.1 5532.8 5546.5 5553.1 5555.6 6055.1 6143.5 6167.5 6169.5 6185.4 6180.1 6203.5 6245.7 6255.3 6267.2 5264.7 5466.8 5578.7 5722.7 5798.6 5169.9 6257.0 6257.7 6271.7 6277.7 5595.9 6040.7 6050.2 6069.6 6094.4 5510.0 5967.9 6066.2 6123.4 6150.1 6072.8 6091.9 6131.9 6146.4 6149.9 6181.4 6197.5 6201.0 6202.8 6211.8 4792.9 4875.7 4878.8 4887.3 4921.9 3956.4 4166.2 4224.7 4234.1 4369.4 5539.0 5543.1 5543.8 5545.4 5583.4 4809.6 6133.5 6138.1 6163.8 6182.3 5511.5 5554.0 5579.8 5583.9 5617.6 5292.1 5296.2 5300.4 5314.8 5315.7 6163.5 6176.3 6271.2 6275.5 6279.9 6216.4 6253.4 6256.8 6267.0 6271.2 6276.7 6281.0 6287.5 6291.7 6302.9 5116.4 5915.1 6047.8 6112.9 6132.5 5266.7 5844.3 6153.8 6163.3 6220.7 5965.7 6006.5 6014.8 6021.2 6029.2 5772.8 5959.2 5973.1 5974.2 5977.1 5744.6 5816.4 5824.6 5837.8 5855.4 5902.3 5915.9 5945.2 5952.4 6008.2 5732.8 5736.0 5778.3 5794.9 5807.4 07:33:56 INFO - PROCESS | 1993 | 07:33:56 INFO - PROCESS | 1993 | [#1] ext.html Cycles:180 Average:63967.73 Median:40105.20 stddev:134048.61 (334.2%) stddev-sans-first:134339.95 07:33:56 INFO - PROCESS | 1993 | Values: 500.7 525.0 533.4 536.7 575.5 27955.6 31287.5 38357.8 39424.4 39546.0 41867.8 42604.8 42610.6 42682.8 42756.6 9364.4 9558.3 9562.3 9581.9 9606.5 9401.6 9549.6 9550.6 9560.1 9564.9 9595.0 9652.4 9654.7 9673.5 9681.8 9510.2 9576.0 9576.4 9583.8 9594.8 9474.8 9600.8 9620.2 9621.3 9625.1 39843.2 40098.4 40112.0 40117.6 40119.8 3167.2 3187.3 3197.7 3207.2 3364.7 28762.0 29058.4 29203.7 29318.1 29388.6 2690.0 2717.9 2780.6 2802.9 2861.4 431931.0 433075.0 433663.8 435273.6 436748.0 58833.7 59645.1 59670.0 59715.7 59765.7 62156.4 63535.0 63559.7 63628.0 63635.0 14159.2 17220.4 17248.8 17297.6 17328.4 13006.7 13038.7 13055.0 13056.7 13085.5 19448.3 19661.0 19671.6 19685.0 19700.0 7910.9 7973.4 7999.8 8002.7 8049.6 913.9 968.7 986.9 1035.3 1088.6 26342.0 29321.9 29567.9 29977.0 30035.1 926.8 1084.7 1120.8 1187.2 1205.9 15194.1 15196.4 15257.8 15556.4 15647.5 466578.0 468987.0 470884.0 473086.0 663864.0 57472.7 57589.7 58353.4 58388.0 58444.7 1347.9 1356.3 1476.2 1478.9 1487.0 21920.9 22669.8 22897.0 28993.0 29607.0 54770.5 55397.7 55706.4 55820.0 56026.4 549984.0 553553.0 553959.0 554808.0 554988.0 26974.6 27453.7 38584.4 40130.0 40312.2 42079.8 42892.0 42972.1 43654.0 44282.0 30781.8 34586.0 34642.7 36531.6 36668.4 28449.0 34754.3 34903.5 35413.0 35415.8 36178.8 36747.3 36840.4 37258.6 37518.8 30394.4 31203.8 32183.2 32259.7 32284.8 19581.6 23953.2 24318.8 24395.5 24541.5 07:33:56 INFO - PROCESS | 1993 | 07:33:56 INFO - PROCESS | 1993 | [#2] jquery.html Cycles:180 Average:34135.84 Median:21361.47 stddev:98355.71 (460.4%) stddev-sans-first:98599.00 07:33:56 INFO - PROCESS | 1993 | Values: 398.6 400.7 401.8 403.2 411.2 12619.5 18557.9 20171.1 21035.9 21083.3 16944.7 17207.4 19695.0 20523.6 21015.9 5286.5 6028.8 6069.5 6077.8 6090.1 5697.5 5914.4 6013.2 6021.6 6026.4 5941.3 5964.2 5970.6 5978.2 5980.3 5674.5 5963.8 5999.1 6013.5 6031.4 5242.1 5245.8 5267.6 5271.5 5280.6 21229.7 24112.6 25444.2 26601.5 27267.0 2073.4 2186.9 2193.2 2320.3 2407.2 15052.8 15472.7 15527.2 15782.2 15813.0 1738.4 1756.8 1801.4 1838.8 1934.6 91057.6 123144.4 124239.8 125437.0 127561.4 11064.8 11314.5 11547.2 11562.2 11741.1 12069.2 14513.9 14622.1 14660.7 14676.3 7189.9 7773.8 8775.5 8905.6 8987.1 8845.5 8852.6 8855.9 8993.7 9001.2 6602.7 6770.6 6793.8 6794.6 6798.3 1870.5 1901.7 1902.9 1910.5 1918.1 945.7 956.2 984.6 1007.3 1031.3 20741.3 21071.7 21272.5 21450.5 21500.7 809.3 980.2 1004.5 1018.7 1073.6 9026.9 9803.4 11005.0 11254.3 11518.1 555021.0 579184.0 593910.0 608372.0 612597.0 123114.0 125984.0 127693.0 127720.0 128185.4 1036.2 1056.4 1062.1 1070.2 1078.2 18728.0 18914.5 19031.8 19052.9 19071.9 36855.6 37877.6 48268.6 48970.0 50078.7 59392.1 61011.0 61749.0 62312.0 62659.0 7599.0 7924.4 8002.0 8064.2 8188.6 12138.3 12209.9 12487.4 12549.2 12675.6 10584.3 10673.3 10816.7 11198.7 11211.6 10385.0 10530.1 10664.8 10699.3 10826.6 9244.0 10730.0 11115.7 11288.2 11365.0 7784.1 7980.5 8133.0 8161.1 8222.6 10666.5 10686.7 10905.1 11017.6 11079.2 07:33:56 INFO - PROCESS | 1993 | 07:33:56 INFO - PROCESS | 1993 | [#3] mootools.html Cycles:180 Average:5662.28 Median:4949.28 stddev:3147.46 (63.6%) stddev-sans-first:3140.14 07:33:56 INFO - PROCESS | 1993 | Values: 1419.0 1484.1 1580.1 1787.7 1947.1 7793.8 8623.1 8869.0 8874.7 8878.2 8509.7 8732.6 8749.2 8753.5 8770.5 2415.1 2447.4 2447.8 2449.1 2449.5 2399.7 2441.2 2447.9 2449.7 2450.9 2420.7 2433.9 2449.2 2450.2 2450.8 2389.8 2415.3 2422.8 2428.0 2432.6 2014.3 2376.4 2412.6 2414.1 2421.7 8505.2 8703.1 8760.9 8770.2 8778.3 5170.2 5378.7 5388.5 5412.5 5419.0 3474.2 3547.7 3643.3 3643.4 3666.8 873.9 1045.2 1045.8 1057.7 1058.1 11061.8 11529.4 11535.4 11537.0 11551.9 4813.5 4836.5 4883.2 4935.1 4964.9 10075.0 10096.8 10098.9 10103.8 10107.4 5369.3 5432.5 5459.0 5471.6 5477.0 4393.5 4586.0 4814.0 4906.6 4922.9 3807.4 3925.6 3962.8 4096.4 4131.4 1152.4 1328.2 1351.3 1355.2 1368.7 651.3 774.9 868.2 886.8 936.1 5475.2 5721.2 5775.2 5825.3 6004.6 493.8 498.1 502.3 510.6 661.5 3860.1 3975.3 4034.4 4051.7 4058.2 6957.5 10274.5 10693.6 10699.4 10699.7 10627.5 10647.0 10749.6 10765.8 10792.5 7669.6 8015.8 8071.4 8108.8 8256.2 5838.2 5952.1 5976.7 6036.6 6059.2 9402.4 9863.9 9865.0 9870.1 9887.4 9575.0 9651.7 9745.9 9750.2 9936.7 7357.0 7625.0 7637.7 7638.1 7643.6 8008.6 8049.1 8150.2 8238.5 8254.7 7319.7 7335.6 7384.8 7499.9 7509.8 7158.0 7281.2 7312.9 7348.0 7444.0 6629.0 6943.7 7003.9 7010.2 7024.7 4830.3 4840.7 4921.7 4945.2 4953.4 4148.5 4853.2 4920.9 4944.7 5152.0 07:33:56 INFO - PROCESS | 1993 | 07:33:56 INFO - PROCESS | 1993 | [#4] prototype.html Cycles:180 Average:4688.78 Median:5143.56 stddev:1487.53 (28.9%) stddev-sans-first:1455.09 07:33:56 INFO - PROCESS | 1993 | Values: 318.6 319.0 327.0 329.3 332.5 4341.4 4421.3 5137.8 5272.3 5298.5 3929.3 4928.3 5210.8 5238.4 5282.1 3375.6 3643.2 3877.3 3996.9 4035.8 3472.5 3892.9 4089.8 4095.7 4143.2 4067.8 4071.4 4111.0 4117.9 4134.9 3881.7 3914.5 4090.6 4101.3 4158.0 3369.4 3587.9 3593.1 3605.9 3610.3 5099.7 5118.6 5130.9 5142.4 5144.7 4231.9 4468.5 4473.4 4589.6 4621.9 4786.8 4836.3 5477.5 5482.2 5500.8 3900.3 3907.2 3924.3 3925.8 3952.9 4994.1 5184.0 5770.6 5804.0 5825.5 3871.1 3953.9 3971.0 3983.1 3985.9 3696.7 4004.0 4023.8 4063.7 4065.4 4135.7 4168.5 4270.7 4647.4 4649.0 5588.5 5608.5 5625.0 5638.9 5642.3 1280.3 1387.9 1427.4 1439.6 1446.0 836.3 895.5 908.6 951.8 966.5 4987.3 5113.4 5253.6 5275.4 5704.2 6254.5 6260.0 6282.5 6305.1 6323.6 5429.6 5616.3 5646.3 5671.2 5729.7 2781.3 3070.9 3083.9 3226.4 3268.3 5435.7 5639.9 6246.0 6449.8 6499.5 6349.2 6381.0 6385.0 6389.2 6395.0 6446.4 6447.8 6454.2 6457.7 6505.1 4574.0 5807.0 6096.5 6209.2 6226.4 5634.0 6064.6 6131.3 6137.9 6165.7 5370.4 6156.2 6402.1 6438.6 6469.7 4127.0 4157.1 4160.3 4164.5 4169.5 5706.3 6208.5 6209.4 6215.4 6215.8 5636.0 5880.4 5946.4 6013.9 6033.9 5274.8 5666.7 6017.7 6025.5 6039.2 4910.7 4960.7 4998.5 5371.8 5934.3 4473.5 5192.0 5533.0 5608.7 5623.1 4594.8 4654.7 5460.9 5497.6 5498.6 07:33:56 INFO - PROCESS | 1993 | 07:33:56 INFO - PROCESS | 1993 | [#5] yui.html Cycles:180 Average:17589.02 Median:64091.34 stddev:25175.71 (39.3%) stddev-sans-first:25214.19 07:33:56 INFO - PROCESS | 1993 | Values: 647.5 660.8 710.7 749.9 752.9 14457.2 14895.6 14937.6 14943.6 14951.5 12323.0 13522.0 13759.9 13778.7 13933.7 921.8 926.9 933.1 935.8 937.2 932.7 933.8 938.2 939.6 939.9 977.3 981.6 982.3 983.8 986.2 975.3 978.2 979.4 979.9 980.0 723.5 724.4 725.9 726.6 727.3 11877.3 12071.6 12088.0 12095.3 12103.3 11202.4 11256.4 11311.7 11531.9 11693.8 9231.8 9346.9 9460.0 9530.9 9989.7 3355.1 3453.2 3460.6 3518.2 3526.8 52897.7 70595.6 78737.6 79294.0 79551.6 9594.7 9631.7 9663.5 9768.3 9913.5 21809.7 21812.3 21848.8 21855.5 21879.5 7390.2 7489.4 7518.4 7559.8 7668.3 4049.2 4114.3 4114.6 4115.2 4125.9 3569.6 3647.3 3653.7 3655.0 3656.6 639.4 658.8 659.8 662.1 666.7 487.9 543.0 564.8 603.4 609.2 7981.6 8268.0 8273.3 8387.7 8554.5 532.5 579.8 584.1 589.6 608.3 3871.7 3877.7 3920.9 3982.1 3991.7 86731.6 91593.6 91714.0 93030.5 95759.0 82195.2 82485.0 82808.0 83071.6 83202.6 57394.0 72745.6 73232.9 73571.0 74063.0 7628.8 7733.5 7856.5 7882.6 8014.5 41619.4 43493.3 43532.6 43614.3 44322.3 63346.0 63900.0 64014.7 64017.0 64165.7 10134.2 10316.0 10353.4 10445.6 10596.4 9159.7 11251.8 11271.8 11297.8 11312.0 10296.7 10357.0 10362.6 10636.0 10695.9 10212.4 10305.9 10325.1 10385.1 10665.5 10408.7 10481.8 10482.2 10701.9 10782.0 8925.0 8939.8 9204.2 9221.5 9327.0 7542.4 8789.0 8881.8 8911.6 9124.4 07:33:56 INFO - PROCESS | 1993 | -------- Summary: end -------- 07:33:56 INFO - PROCESS | 1993 | 07:33:56 INFO - TEST-INFO | 1993: exit 0 07:33:56 INFO - TEST-OK | dromaeo_css | took 1114686ms 07:33:56 INFO - TEST-START | kraken 07:33:56 INFO - operating with platform_type : mac_ 07:33:56 INFO - Initialising browser for kraken test... 07:33:56 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpzhApeT/profile http://localhost:52677/getInfo.html) 07:33:58 INFO - PROCESS | 1998 | __metrics Screen width/height:1600/1200 07:33:58 INFO - PROCESS | 1998 | colorDepth:24 07:33:58 INFO - PROCESS | 1998 | Browser inner width/height: 1024/689 07:33:58 INFO - PROCESS | 1998 | __metrics 07:33:59 INFO - PROCESS | 1998 | 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" 07:33:59 ERROR - PROCESS | 1998 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:33:59 INFO - TEST-INFO | 1998: exit 0 07:33:59 INFO - Browser initialized. 07:33:59 INFO - Running cycle 1/1 for kraken test... 07:33:59 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpzhApeT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:34:11 INFO - PROCESS | 2000 | RSS: Main: 239325184 07:34:11 INFO - PROCESS | 2000 | 07:34:14 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:52677/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52677/tests/kraken/driver.html?testName=audio-beat-detection) 07:34:14 INFO - PROCESS | 2000 | RSS: Main: 286691328 07:34:14 INFO - PROCESS | 2000 | 07:34:17 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:52677/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52677/tests/kraken/driver.html?testName=audio-dft) 07:34:18 INFO - PROCESS | 2000 | RSS: Main: 295862272 07:34:18 INFO - PROCESS | 2000 | 07:34:21 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:52677/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52677/tests/kraken/driver.html?testName=audio-fft) 07:34:22 INFO - PROCESS | 2000 | RSS: Main: 380645376 07:34:22 INFO - PROCESS | 2000 | 07:34:24 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:52677/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52677/tests/kraken/driver.html?testName=audio-oscillator) 07:34:25 INFO - PROCESS | 2000 | RSS: Main: 280825856 07:34:25 INFO - PROCESS | 2000 | 07:34:27 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:52677/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52677/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:34:27 INFO - PROCESS | 2000 | RSS: Main: 284893184 07:34:27 INFO - PROCESS | 2000 | 07:34:30 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:52677/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52677/tests/kraken/driver.html?testName=imaging-darkroom) 07:34:31 INFO - PROCESS | 2000 | RSS: Main: 321622016 07:34:31 INFO - PROCESS | 2000 | 07:34:34 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:52677/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52677/tests/kraken/driver.html?testName=imaging-desaturate) 07:34:34 INFO - PROCESS | 2000 | RSS: Main: 324374528 07:34:34 INFO - PROCESS | 2000 | 07:34:37 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:52677/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52677/tests/kraken/driver.html?testName=json-parse-financial) 07:34:38 INFO - PROCESS | 2000 | RSS: Main: 324059136 07:34:38 INFO - PROCESS | 2000 | 07:34:39 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:52677/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52677/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:34:40 INFO - PROCESS | 2000 | RSS: Main: 313040896 07:34:40 INFO - PROCESS | 2000 | 07:34:42 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:52677/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52677/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:34:42 INFO - PROCESS | 2000 | RSS: Main: 319901696 07:34:42 INFO - PROCESS | 2000 | 07:34:44 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:52677/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52677/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:34:45 INFO - PROCESS | 2000 | RSS: Main: 322252800 07:34:45 INFO - PROCESS | 2000 | 07:34:48 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:52677/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52677/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:34:49 INFO - PROCESS | 2000 | RSS: Main: 326561792 07:34:49 INFO - PROCESS | 2000 | 07:34:52 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:52677/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52677/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:34:52 INFO - PROCESS | 2000 | RSS: Main: 324313088 07:34:52 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:52677/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52677/tests/kraken/driver.html?testName=ai-astar) 07:34:54 INFO - PROCESS | 2000 | RSS: Main: 389861376 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | __start_tp_report 07:34:54 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 07:34:54 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 07:34:54 INFO - PROCESS | 2000 | |i|pagename|runs| 07:34:54 INFO - PROCESS | 2000 | |0;ai-astar;111;111;106;112;112;112;111;110;103;111 07:34:54 INFO - PROCESS | 2000 | |1;audio-beat-detection;159;120;149;171;140;175;157;121;174;118 07:34:54 INFO - PROCESS | 2000 | |2;audio-dft;187;184;186;183;183;180;181;180;183;183 07:34:54 INFO - PROCESS | 2000 | |3;audio-fft;77;72;87;90;60;66;81;116;109;58 07:34:54 INFO - PROCESS | 2000 | |4;audio-oscillator;95;99;133;78;81;81;123;81;75;127 07:34:54 INFO - PROCESS | 2000 | |5;imaging-gaussian-blur;88;93;134;131;87;83;89;86;88;85 07:34:54 INFO - PROCESS | 2000 | |6;imaging-darkroom;92;92;93;93;92;92;93;93;92;92 07:34:54 INFO - PROCESS | 2000 | |7;imaging-desaturate;85;84;84;83;85;84;82;85;86;83 07:34:54 INFO - PROCESS | 2000 | |8;json-parse-financial;60;61;61;58;59;58;59;77;60;57 07:34:54 INFO - PROCESS | 2000 | |9;json-stringify-tinderbox;64;63;74;74;69;68;67;68;68;70 07:34:54 INFO - PROCESS | 2000 | |10;stanford-crypto-aes;83;83;84;83;80;70;81;99;106;106 07:34:54 INFO - PROCESS | 2000 | |11;stanford-crypto-ccm;128;156;127;153;156;148;147;134;179;140 07:34:54 INFO - PROCESS | 2000 | |12;stanford-crypto-pbkdf2;171;171;172;173;172;169;171;171;175;178 07:34:54 INFO - PROCESS | 2000 | |13;stanford-crypto-sha256-iterative;69;68;69;68;69;71;72;66;68;67 07:34:54 INFO - PROCESS | 2000 | __end_tp_report 07:34:54 INFO - PROCESS | 2000 | __start_cc_report 07:34:54 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,1977 07:34:54 INFO - PROCESS | 2000 | __end_cc_report 07:34:54 INFO - PROCESS | 2000 | __startTimestamp1461940494613__endTimestamp 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | ------- Summary: start ------- 07:34:54 INFO - PROCESS | 2000 | Number of tests: 14 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.00 (2.7%) stddev-sans-first:3.15 07:34:54 INFO - PROCESS | 2000 | Values: 111.0 111.0 106.0 112.0 112.0 112.0 111.0 110.0 103.0 111.0 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:158.00 stddev:22.64 (14.3%) stddev-sans-first:23.68 07:34:54 INFO - PROCESS | 2000 | Values: 159.0 120.0 149.0 171.0 140.0 175.0 157.0 121.0 174.0 118.0 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:2.31 (1.3%) stddev-sans-first:1.94 07:34:54 INFO - PROCESS | 2000 | Values: 187.0 184.0 186.0 183.0 183.0 180.0 181.0 180.0 183.0 183.0 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | [#3] audio-fft Cycles:10 Average:81.60 Median:74.50 stddev:19.48 (26.1%) stddev-sans-first:20.59 07:34:54 INFO - PROCESS | 2000 | Values: 77.0 72.0 87.0 90.0 60.0 66.0 81.0 116.0 109.0 58.0 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:81.00 stddev:22.34 (27.6%) stddev-sans-first:23.68 07:34:54 INFO - PROCESS | 2000 | Values: 95.0 99.0 133.0 78.0 81.0 81.0 123.0 81.0 75.0 127.0 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:87.50 stddev:19.22 (22.0%) stddev-sans-first:20.14 07:34:54 INFO - PROCESS | 2000 | Values: 88.0 93.0 134.0 131.0 87.0 83.0 89.0 86.0 88.0 85.0 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | [#6] imaging-darkroom Cycles:10 Average:92.40 Median:92.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 07:34:54 INFO - PROCESS | 2000 | Values: 92.0 92.0 93.0 93.0 92.0 92.0 93.0 93.0 92.0 92.0 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.50 stddev:1.20 (1.4%) stddev-sans-first:1.22 07:34:54 INFO - PROCESS | 2000 | Values: 85.0 84.0 84.0 83.0 85.0 84.0 82.0 85.0 86.0 83.0 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:60.00 stddev:5.77 (9.6%) stddev-sans-first:6.11 07:34:54 INFO - PROCESS | 2000 | Values: 60.0 61.0 61.0 58.0 59.0 58.0 59.0 77.0 60.0 57.0 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:3.60 (5.3%) stddev-sans-first:3.43 07:34:54 INFO - PROCESS | 2000 | Values: 64.0 63.0 74.0 74.0 69.0 68.0 67.0 68.0 68.0 70.0 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:83.00 stddev:11.99 (14.4%) stddev-sans-first:12.61 07:34:54 INFO - PROCESS | 2000 | Values: 83.0 83.0 84.0 83.0 80.0 70.0 81.0 99.0 106.0 106.0 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:150.50 stddev:15.64 (10.4%) stddev-sans-first:15.04 07:34:54 INFO - PROCESS | 2000 | Values: 128.0 156.0 127.0 153.0 156.0 148.0 147.0 134.0 179.0 140.0 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:172.00 stddev:2.54 (1.5%) stddev-sans-first:2.65 07:34:54 INFO - PROCESS | 2000 | Values: 171.0 171.0 172.0 173.0 172.0 169.0 171.0 171.0 175.0 178.0 07:34:54 INFO - PROCESS | 2000 | 07:34:54 INFO - PROCESS | 2000 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.77 (2.6%) stddev-sans-first:1.87 07:34:54 INFO - PROCESS | 2000 | Values: 69.0 68.0 69.0 68.0 69.0 71.0 72.0 66.0 68.0 67.0 07:34:54 INFO - PROCESS | 2000 | -------- Summary: end -------- 07:34:54 INFO - PROCESS | 2000 | 07:34:55 INFO - TEST-INFO | 2000: exit 0 07:34:55 INFO - TEST-OK | kraken | took 59051ms 07:34:55 INFO - SUITE-END | took 1173s 07:34:55 INFO - Completed test suite (00:19:33) 07:34:55 INFO - javascript benchmark 07:34:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3335.7498187635924, 3369.7809642373245, 3377.9831100844485, 3404.0468668772724, 3445.983434886708, 4451.265541185709, 5429.294191755066, 5552.4169962154, 5572.721363931808, 5615.466530679589, 4517.616002639771, 5619.606627536064, 5688.402717714643, 5695.174199741045, 5728.42715728427, 5061.367329083864, 5099.821506247282, 5122.564582010515, 5149.510796474347, 5243.475652434745, 5210.983858147643, 5254.211868219779, 5263.631545791796, 5267.1309233976535, 5287.41838397776, 4102.979485102585, 5065.088284108859, 5079.31429257053, 5100.336956195708, 5194.818181363653, 5140.228965655144, 5160.664556803796, 5167.431582525919, 5169.043726910533, 5251.238570407269, 5104.081265372231, 5114.948850511484, 5127.8205262816, 5157.5616072633875, 5226.3989641191365, 5439.075357189287, 5532.7786888524415, 5546.500814926676, 5553.111502159635, 5555.583331250132, 6055.130578955452, 6143.508519318444, 6167.537434692416, 6169.475594574466, 6185.35053819347, 6180.103884936659, 6203.534734894856, 6245.656488893109, 6255.280642726054, 6267.1539342189135, 5264.684118952875, 5466.753996070186, 5578.665280083208, 5722.713864306809, 5798.565107616903, 5169.922451163236, 6257.0, 6257.7184026718905, 6271.717772700239, 6277.748890044439, 5595.888082238333, 6040.697965101727, 6050.21347224858, 6069.635821850703, 6094.360092190344, 5509.972450137804, 5967.92577336075, 6066.211392518944, 6123.374132580074, 6150.138980542728, 6072.848178795565, 6091.8690759028295, 6131.9272270139245, 6146.416090471398, 6149.86227547905, 6181.350958149419, 6197.4732147767045, 6201.0388389799655, 6202.844928876814, 6211.81364559064, 4792.880177995578, 4875.731834749052, 4878.829240976549, 4887.29134275528, 4921.8523444296725, 3956.3867600521967, 4166.208420400114, 4224.66202703783, 4234.1108367242605, 4369.388285640013, 5538.972305138448, 5543.113101903676, 5543.7782488700805, 5545.3622833374675, 5583.3858275589655, 4809.639277054235, 6133.478654314344, 6138.14066030756, 6163.7842675506145, 6182.258129024456, 5511.476409741068, 5554.028045092174, 5579.776808927679, 5583.916241256385, 5617.606767526234, 5292.100342941709, 5296.232046353257, 5300.416954135042, 5314.7608357624, 5315.73421328932, 6163.537734670007, 6176.320604733565, 6271.247450305901, 6275.529335299871, 6279.874402511924, 6216.409441103088, 6253.37466253371, 6256.843578910563, 6267.0, 6271.184745982993, 6276.686165691788, 6281.026440901667, 6287.497000239879, 6291.716872740829, 6302.936970630419, 5116.411612664591, 5915.142304365929, 6047.758089676364, 6112.938870611237, 6132.5400594956445, 5266.657667251617, 5844.26946631671, 6153.84615384619, 6163.291221509584, 6220.657863817533, 5965.70171491415, 6006.519478441627, 6014.759409623566, 6021.157038014594, 6029.246344206974, 5772.7690892363835, 5959.22530071088, 5973.104034394875, 5974.1934838796205, 5977.073553599199, 5744.569157313134, 5816.418358164319, 5824.592278540462, 5837.766489340379, 5855.38518455556, 5902.2622172228475, 5915.881682366415, 5945.19739835134, 5952.375000625046, 6008.188894499362, 5732.828015159552, 5735.971320143372, 5778.27771528559, 5794.855128621818, 5807.390224026416], "value": 5564.849633590583, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.69707826764807, 525.0103554799202, 533.4425525326034, 536.7316341829086, 575.5194412665422, 27955.580666289996, 31287.530687039685, 38357.80821095894, 39424.40863387052, 39546.0, 41867.790661046725, 42604.78697606515, 42610.57389426105, 42682.78658606703, 42756.57243427565, 9364.39131456455, 9558.283128765335, 9562.330636855422, 9581.904180958205, 9606.519674016306, 9401.62393504259, 9549.570269337897, 9550.570224339921, 9560.13958743713, 9564.904350956505, 9595.040495950385, 9652.420854748703, 9654.662086826962, 9673.516324183798, 9681.75795605112, 9510.239180865514, 9576.0, 9576.425414475154, 9583.808323833555, 9594.760130996747, 9474.763130921714, 9600.759981000461, 9620.182284505825, 9621.278404119648, 9625.085616866387, 39843.20313593712, 40098.39852402217, 40112.0, 40117.59882401197, 40119.799401002805, 3167.224030112637, 3187.2828613561996, 3197.6802319767835, 3207.1501052220947, 3364.680355366236, 28762.0, 29058.41883162325, 29203.70796292031, 29318.120456386343, 29388.559171612444, 2689.9865500672568, 2717.9320516987036, 2780.5829125631117, 2802.8598570071413, 2861.399106187703, 431931.0, 433075.0, 433663.83168084273, 435273.6490033442, 436748.0, 58833.70583147057, 59645.10532342018, 59670.0, 59715.70142149348, 59765.70117149386, 62156.378436215964, 63535.0, 63559.682201588694, 63628.0, 63635.0, 14159.221242831538, 17220.397286094925, 17248.827511724972, 17297.56756081083, 17328.39350622722, 13006.739865202831, 13038.674033149247, 13055.0, 13056.673583160496, 13085.476580936656, 19448.319308824408, 19661.0, 19671.60656786885, 19685.01574921248, 19700.0, 7910.920890791133, 7973.441859069925, 7999.840083156726, 8002.719225020841, 8049.55727434985, 913.8949020862553, 968.719071469266, 986.8569057486624, 1035.2649618770756, 1088.646189988241, 26342.0, 29321.853390733337, 29567.852160739058, 29976.95080672166, 30035.098947031624, 926.8470702334039, 1084.6691759013577, 1120.7814476177068, 1187.1986409173946, 1205.9155859089778, 15194.088354698753, 15196.392144314104, 15257.847421525865, 15556.377744890304, 15647.452339168301, 466578.0, 468987.0, 470884.0, 473086.0, 663864.0, 57472.71263643655, 57589.712051440314, 58353.416465835646, 58388.0, 58444.70777646085, 1347.93934272956, 1356.3082827757717, 1476.2397365356849, 1478.8669019788272, 1487.0334282716105, 21920.89039554792, 22669.773302267426, 22897.00410715267, 28993.0, 29607.0, 54770.452295476534, 55397.72301138468, 55706.44293557013, 55820.0, 56026.43973560212, 549984.0, 553553.0, 553959.0, 554808.0, 554988.0, 26974.595381068906, 27453.666438352164, 38584.42123368096, 40130.0, 40312.19375612413, 42079.7896010518, 42892.0, 42972.14055718805, 43654.0, 44282.0, 30781.846090769403, 34585.962421127406, 34642.65357346495, 36531.63468365389, 36668.44997325096, 28449.004284849932, 34754.30491390209, 34903.476447852794, 35413.0, 35415.82292088523, 36178.8191059043, 36747.26505469822, 36840.44739328966, 37258.62741372552, 37518.812405937795, 30394.392112158075, 31203.84398077995, 32183.176659490942, 32259.677403226608, 32284.83857580697, 19581.608367832847, 23953.16163934254, 24318.784060796537, 24395.4991620785, 24541.509169816145], "value": 19527.673790266592, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.60338962732084, 400.67945643485206, 401.752921952999, 403.1714826032503, 411.2022676008543, 12619.495220191204, 18557.907210463964, 20171.09230084646, 21035.894820525915, 21083.26208582698, 16944.745828812578, 17207.397741079065, 19695.015249237553, 20523.589528209428, 21015.894920525414, 5286.471352864712, 6028.819135425944, 6069.544784141207, 6077.78727744529, 6090.147379366892, 5697.544196464273, 5914.378990206031, 6013.1581578579035, 6021.638701677914, 6026.427489388501, 5941.316748573904, 5964.2246507953905, 5970.582059255854, 5978.22283103196, 5980.342162362137, 5674.546036317085, 5963.761449542013, 5999.070144127667, 6013.458788709037, 6031.427014433643, 5242.135047717122, 5245.842624721265, 5267.578593712532, 5271.499207575274, 5280.577553795687, 21229.681554776536, 24112.63831042536, 25444.236672899842, 26601.46797064067, 27267.045653402034, 2073.409078412645, 2186.9234576789736, 2193.1994821890053, 2320.2691152287143, 2407.1574948767966, 15052.774208386883, 15472.690546189013, 15527.223638818014, 15782.210889455482, 15812.97215680977, 1738.4176300939075, 1756.7891852977596, 1801.351513455155, 1838.7793464784177, 1934.5937353155855, 91057.63413548803, 123144.38427807804, 124239.75760242462, 125437.0, 127561.36219318937, 11064.834027489595, 11314.490847911864, 11547.249428787101, 11562.190646654823, 11741.119416043832, 12069.215500992408, 14513.854861451462, 14622.122672639676, 14660.706785864437, 14676.339564719614, 7189.92810071903, 7773.833924911309, 8775.517346546001, 8905.643774248958, 8987.146221108984, 8845.469271843709, 8852.557372131369, 8855.867161992575, 8993.685221017233, 9001.18989290967, 6602.669866506655, 6770.627615481196, 6793.762218322335, 6794.558353706993, 6798.320167983261, 1870.5417172792752, 1901.7052356884706, 1902.876313039648, 1910.4555201767707, 1918.1176658737138, 945.6831961293044, 956.2302346611045, 984.5963155106372, 1007.3351587951917, 1031.2626472072504, 20741.28353154346, 21071.68392474114, 21272.468188295108, 21450.463738406354, 21500.677489837664, 809.3242142810819, 980.2109302011949, 1004.5278719002057, 1018.7147598672384, 1073.63496411219, 9026.916769987512, 9803.411795292306, 11005.0, 11254.324740515594, 11518.078553715683, 555021.0, 579184.0, 593910.0, 608372.0, 612597.0, 123114.0, 125984.0, 127693.0, 127720.0, 128185.35907320591, 1036.171252480732, 1056.3872953686844, 1062.1290541755686, 1070.2454769387564, 1078.191356482638, 18727.96996165224, 18914.51292246521, 19031.809681903003, 19052.856828590327, 19071.90464047671, 36855.63144368522, 37877.62122378851, 48268.55194344175, 48970.0, 50078.74960625319, 59392.109118364126, 61011.0, 61749.0, 62312.0, 62659.0, 7598.962005189938, 7924.366050716044, 8002.0, 8064.193580641889, 8188.590570471333, 12138.271703697454, 12209.877901220874, 12487.375631218221, 12549.247045177319, 12675.556355527513, 10584.259101862795, 10673.306235094695, 10816.729581760204, 11198.664040078811, 11211.551537938718, 10385.0, 10530.104581175461, 10664.786704265716, 10699.251052426567, 10826.56693732242, 9244.0, 10729.980651838063, 11115.72210694739, 11288.209825312479, 11365.0, 7784.065912090586, 7980.521168729895, 8133.0, 8161.102278749451, 8222.62998165096, 10666.466676665981, 10686.689961093536, 10905.097099495908, 11017.559297628326, 11079.169062320198], "value": 9627.982655517393, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.999605278279, 1484.1169504145034, 1580.138824340734, 1787.7229029500425, 1947.133525581117, 7793.766187014385, 8623.094575069621, 8869.02440731519, 8874.733757987255, 8878.15657512536, 8509.702160424386, 8732.563371831415, 8749.168828961254, 8753.474791512514, 8770.517621530813, 2415.0581273303424, 2447.412620970972, 2447.840890342131, 2449.130558651671, 2449.510097980402, 2399.734573311743, 2441.2310122311414, 2447.865367404792, 2449.6570480132796, 2450.8652024138664, 2420.7095148582107, 2433.902643894251, 2449.2040086971715, 2450.2281781238944, 2450.82844200906, 2389.7968672662846, 2415.287490190398, 2422.7577242275806, 2427.9635805462844, 2432.6107822748277, 2014.2647933504165, 2376.358383236534, 2412.5657381671294, 2414.0947144820693, 2421.6609674645565, 8505.234528892368, 8703.129687031309, 8760.8685869712, 8770.210681038738, 8778.341624378134, 5170.224466330043, 5378.704171270579, 5388.515033646991, 5412.512873841334, 5419.024575576394, 3474.1662001119803, 3547.6984456321243, 3643.2895585360866, 3643.3806252937065, 3666.834992425347, 873.860182370824, 1045.2369770067894, 1045.7594753206804, 1057.6615483045427, 1058.1217589400856, 11061.778764424747, 11529.365884876328, 11535.365554894477, 11536.96167344943, 11551.884481155164, 4813.542713442217, 4836.540528649843, 4883.169861123618, 4935.087008903364, 4964.900701986012, 10075.0, 10096.848547271797, 10098.899011009942, 10103.84844227337, 10107.39355638664, 5369.328833895763, 5432.483914028161, 5459.0, 5471.562275017989, 5476.972615136899, 4393.494748103945, 4586.0, 4814.0, 4906.582940450102, 4922.852314430573, 3807.4098514730263, 3925.5878132796215, 3962.841486340572, 4096.426500289962, 4131.421600975866, 1152.4410660829492, 1328.167129361475, 1351.3175846197607, 1355.1801160298076, 1368.746781845342, 651.2510612795229, 774.9147593764682, 868.1708967935606, 886.827068721606, 936.0732874454377, 5475.233467314579, 5721.199032135504, 5775.191473193756, 5825.33008703996, 6004.639721616717, 493.77286448233497, 498.14568015852984, 502.2546650389866, 510.6246908522233, 661.4741280681869, 3860.0735823402183, 3975.284448799244, 4034.435179074932, 4051.6961227908023, 4058.1680755445063, 6957.478189135733, 10274.486275686186, 10693.625723099654, 10699.358038517557, 10699.679009629723, 10627.52176152075, 10647.0, 10749.570017199225, 10765.78468430627, 10792.46037698112, 7669.578173200416, 8015.7595272141925, 8071.4349995500925, 8108.797280067927, 8256.215659512336, 5838.1826544282985, 5952.107183922446, 5976.671283079472, 6036.607620504828, 6059.242594675666, 9402.43585384879, 9863.852042219229, 9864.950675246579, 9870.062344077302, 9887.406755594688, 9575.0, 9651.662191823252, 9745.853812192965, 9750.219982401533, 9936.701898943043, 7356.96321518389, 7625.0, 7637.6563054661565, 7638.083429988437, 7643.617819109134, 8008.599570021592, 8049.074356449083, 8150.192714161382, 8238.464499807493, 8254.711085111992, 7319.707211711472, 7335.633218339169, 7384.815379615553, 7499.925000749922, 7509.812254693677, 7158.0, 7281.235470275757, 7312.9396237546325, 7348.0, 7443.962780186281, 6628.966855165693, 6943.722251109899, 7003.894941575779, 7010.193827709674, 7024.719011239493, 4830.2513110467935, 4840.7337596432535, 4921.68009079423, 4945.208766597327, 4953.356063711694, 4148.481439820022, 4853.174960256694, 4920.92618610714, 4944.6785958914, 5152.0], "value": 4506.754443811191, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.60174781523096, 319.0190165241882, 326.9722073623741, 329.3446042375672, 332.51784911877786, 4341.351775416997, 4421.270490369086, 5137.794488220471, 5272.340957380323, 5298.4966428189355, 3929.2927273090904, 4928.275103713708, 5210.7655155518, 5238.423773384925, 5282.072043704049, 3375.611804642461, 3643.234920666663, 3877.2827026999953, 3996.8800935971967, 4035.7982100894983, 3472.461768425898, 3892.9026774330587, 4089.7670910607526, 4095.6518695910736, 4143.19207754488, 4067.776272305022, 4071.42999980003, 4110.979445102786, 4117.9176416471655, 4134.917301653965, 3881.7485858202176, 3914.53025636924, 4090.550039495653, 4101.323281658522, 4158.0, 3369.393509168349, 3587.856485740567, 3593.1196856770257, 3605.9278814423565, 3610.332088563624, 5099.745012749348, 5118.59051275897, 5130.897382052375, 5142.434332223453, 5144.691318520863, 4231.91536169278, 4468.463784345867, 4473.351364052227, 4589.5639914208095, 4621.930671039937, 4786.7845946932475, 4836.250381190921, 5477.4796394342475, 5482.205080263379, 5500.80747173847, 3900.278448487039, 3907.159960608483, 3924.2543916655745, 3925.8429662813455, 3952.920941581181, 4994.07609592223, 5183.974080129575, 5770.567207459458, 5803.95528804815, 5825.504832089235, 3871.0515923598336, 3953.881383558498, 3971.0, 3983.1237127831832, 3985.9003524911527, 3696.722745794076, 4003.979980100081, 4023.8390464381096, 4063.6952228582973, 4065.4105154752397, 4135.697255364551, 4168.478940132483, 4270.658347332268, 4647.350190682259, 4648.953510464919, 5588.469095435927, 5608.495235428831, 5624.971875140598, 5638.887222255532, 5642.294713160855, 1280.2702459598127, 1387.882030027459, 1427.4076258352875, 1439.5897169306697, 1445.9566213013627, 836.3016880904391, 895.5029958373035, 908.5502676175336, 951.7620594851287, 966.4829316315737, 4987.251912213124, 5113.446154922368, 5253.605979551549, 5275.366955965309, 5704.201411802351, 6254.499640028786, 6260.0, 6282.465990390777, 6305.054241863665, 6323.5889667172405, 5429.56563474921, 5616.297962754656, 5646.265985421869, 5671.2060311556415, 5729.684867332337, 2781.2629653141935, 3070.8618112185004, 3083.892063777802, 3226.3547290541514, 3268.313654132611, 5435.728213589305, 5639.943600564024, 6245.968770156211, 6449.774257900951, 6499.512536559777, 6349.206349206349, 6381.010943303795, 6384.968075159687, 6389.233292004989, 6394.968025159845, 6446.355364463516, 6447.806565803034, 6454.225088100716, 6457.709403076873, 6505.146033380463, 4573.993721381291, 5806.983777838946, 6096.512279017579, 6209.223847019122, 6226.377362263737, 5634.0, 6064.575479716377, 6131.325554189125, 6137.938620613737, 6165.660888651168, 5370.436104209158, 6156.199694039746, 6402.135711678864, 6438.581492202992, 6469.732784943573, 4127.009517715786, 4157.10622216225, 4160.271952408377, 4164.521080075709, 4169.45797046382, 5706.343770466449, 6208.534359922934, 6209.410106039919, 6215.378462153749, 6215.751369945152, 5636.013697602985, 5880.353161152184, 5946.405359464019, 6013.939860601338, 6033.87932241344, 5274.762635681327, 5666.688332141772, 6017.669028203491, 6025.487833534199, 6039.154518367344, 4910.680805747615, 4960.668485811662, 4998.525140111684, 5371.758270877742, 5934.258217722785, 4473.530279320755, 5192.0, 5533.0, 5608.663480191201, 5623.0721930880945, 4594.816207351669, 4654.6741728078705, 5460.914583260445, 5497.642653227527, 5498.635586697758], "value": 4223.215553105859, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.5370110371084, 660.8480049588594, 710.7121615745625, 749.8612756640018, 752.9247075292471, 14457.204853733041, 14895.553133405989, 14937.551873443786, 14943.551693449186, 14951.47669831556, 12323.0, 13522.0, 13759.93120034401, 13778.655533611665, 13933.651658708537, 921.7925966657499, 926.8609708543705, 933.0809152984305, 935.7847695030147, 937.2127412973101, 932.6828878181417, 933.8412469880137, 938.1884669760676, 939.5959737312953, 939.8590211468301, 977.2524019125375, 981.6220755009301, 982.3172894838091, 983.7884854756226, 986.2208855004537, 975.3270243531975, 978.1685567267837, 979.4417182206074, 979.8726165598426, 980.0003995924153, 723.4935545118385, 724.4132252875188, 725.8548290341953, 726.6330503095903, 727.2690945599692, 11877.287362758263, 12071.637850864488, 12088.0, 12095.274283542927, 12103.334316612583, 11202.43987800615, 11256.38089905055, 11311.717207069807, 11531.942340288246, 11693.824592631117, 9231.769205769842, 9346.906530934739, 9459.952700236523, 9530.904690953072, 9989.650362237287, 3355.1276668066234, 3453.188500702333, 3460.602030766469, 3518.1908161123083, 3526.806025668613, 52897.7355113222, 70595.64702176457, 78737.60631196808, 79294.0, 79551.60224198842, 9594.712158635251, 9631.71104866855, 9663.46850923192, 9768.316217864682, 9913.504324783731, 21809.67285490719, 21812.345629631138, 21848.781512184993, 21855.45361365947, 21879.45301367447, 7390.150132734697, 7489.440456112599, 7518.436117291225, 7559.848803023909, 7668.348190403766, 4049.169920166418, 4114.280000999813, 4114.629683328455, 4115.238680844053, 4125.876223713293, 3569.5538057742783, 3647.3434781739543, 3653.725970552219, 3655.049687081378, 3656.597774244831, 639.4277121975806, 658.7661380210052, 659.7789740436912, 662.1127688896901, 666.7166454256921, 487.91461494238365, 542.9782808687609, 564.8305508347479, 603.4380086545729, 609.2171559546051, 7981.640826162837, 8268.049174344907, 8273.296769774637, 8387.706430275033, 8554.486730796172, 532.5127508329834, 579.8202557207279, 584.0596639410545, 589.6108568344872, 608.3399511529951, 3871.709621778378, 3877.709171812069, 3920.862769803043, 3982.064214909494, 3991.7006224532697, 86731.56634216914, 91593.62609560862, 91714.0, 93030.53484732668, 95759.0437993892, 82195.17804821995, 82485.0, 82808.0, 83071.5846420764, 83202.58398708088, 57394.0, 72745.63627181831, 73232.90150647744, 73571.0, 74063.0, 7628.771136865903, 7733.535987840747, 7856.489328193649, 7882.566458844819, 8014.488342970395, 41619.37570936499, 43493.34759978666, 43532.56467435285, 43614.345784813886, 44322.335164971904, 63346.04980925198, 63900.0, 64014.719705606556, 64017.0, 64165.67917160384, 10134.23993200498, 10316.0, 10353.4305613192, 10445.582176712845, 10596.417197054236, 9159.679411220575, 11251.831222531833, 11271.774564508827, 11297.830532542182, 11312.03847672957, 10296.691099267035, 10357.0, 10362.585496580354, 10636.0, 10695.94652026735, 10212.438315892698, 10305.896941030494, 10325.122364599094, 10385.117265032557, 10665.514604375703, 10408.687739367831, 10481.79036419252, 10482.161427085968, 10701.946490267499, 10782.029617334478, 8925.0, 8939.821203576023, 9204.171624553823, 9221.49281789508, 9327.0, 7542.434317426325, 8789.0, 8881.822363552563, 8911.55442227899, 9124.361294709306], "value": 6701.2526743776425, "unit": "score"}], "name": "dromaeo_css", "value": 7148.65836890917, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 106.0, 112.0, 112.0, 112.0, 111.0, 110.0, 103.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 120.0, 149.0, 171.0, 140.0, 175.0, 157.0, 121.0, 174.0, 118.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 186.0, 183.0, 183.0, 180.0, 181.0, 180.0, 183.0, 183.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 87.0, 90.0, 60.0, 66.0, 81.0, 116.0, 109.0, 58.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 133.0, 78.0, 81.0, 81.0, 123.0, 81.0, 75.0, 127.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 93.0, 134.0, 131.0, 87.0, 83.0, 89.0, 86.0, 88.0, 85.0], "value": 96.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 93.0, 92.0, 92.0, 93.0, 93.0, 92.0, 92.0], "value": 92.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 83.0, 85.0, 84.0, 82.0, 85.0, 86.0, 83.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 58.0, 59.0, 58.0, 59.0, 77.0, 60.0, 57.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 74.0, 74.0, 69.0, 68.0, 67.0, 68.0, 68.0, 70.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 83.0, 80.0, 70.0, 81.0, 99.0, 106.0, 106.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 156.0, 127.0, 153.0, 156.0, 148.0, 147.0, 134.0, 179.0, 140.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 172.0, 173.0, 172.0, 169.0, 171.0, 171.0, 175.0, 178.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 68.0, 69.0, 71.0, 72.0, 66.0, 68.0, 67.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1497.8999999999999, "alertThreshold": 2.0}]} 07:34:55 INFO - Return code: 0 07:34:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:34:55 ERROR - # TBPL SUCCESS # 07:34:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:34:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:34:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:34:55 INFO - 2016-04-29 07:34:55.938 screenresolution[2004:30569] starting screenresolution argv=screenresolution get 07:34:55 INFO - 2016-04-29 07:34:55.940 screenresolution[2004:30569] Display 0: 1600x1200x32@60 07:34:55 INFO - 2016-04-29 07:34:55.947 screenresolution[2005:30572] starting screenresolution argv=screenresolution list 07:34:55 INFO - Available Modes on Display 0 07:34:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:34:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:34:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:34:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:34:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:34:56 INFO - Intel Iris: 07:34:56 INFO - Chipset Model: Intel Iris 07:34:56 INFO - Type: GPU 07:34:56 INFO - Bus: Built-In 07:34:56 INFO - VRAM (Dynamic, Max): 1536 MB 07:34:56 INFO - Vendor: Intel (0x8086) 07:34:56 INFO - Device ID: 0x0a2e 07:34:56 INFO - Revision ID: 0x0009 07:34:56 INFO - Displays: 07:34:56 INFO - Display: 07:34:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:34:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:34:56 INFO - Display Serial Number: 1600x1200 60 07:34:56 INFO - Main Display: Yes 07:34:56 INFO - Mirror: Off 07:34:56 INFO - Online: Yes 07:34:56 INFO - Rotation: Supported 07:34:56 INFO - Return code: 0 07:34:56 INFO - Running post-action listener: _resource_record_post_action 07:34:56 INFO - Running post-run listener: _resource_record_post_run 07:34:57 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 12952576; Write bytes: 708282880; Read time: 183; Write time: 2898 07:34:57 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 380932608; Write bytes: 376581632; Read time: 28650; Write time: 761 07:34:57 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 12952576; Write bytes: 308509696; Read time: 183; Write time: 2089 07:34:57 INFO - Running post-run listener: _upload_blobber_files 07:34:57 INFO - Blob upload gear active. 07:34:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:34:57 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 07:34:57 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:34:57 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:34:57 INFO - (blobuploader) - INFO - Open directory for files ... 07:34:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:34:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:34:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:58 INFO - (blobuploader) - INFO - Done attempting. 07:34:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:34:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:34:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:59 INFO - (blobuploader) - INFO - Done attempting. 07:34:59 INFO - (blobuploader) - INFO - Iteration through files over. 07:34:59 INFO - Return code: 0 07:34:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:34:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:34:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/852e0f99129ce86f384d3a2226258317babe1acfddf77e19f4a792ba173ddff8c18981759e110c8b3b195d320a25f775ad439e937a21eb4511357f684bba100a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70e796e3726d59437a0e693e448f9a28a1f364a57a99cfd09e24c6417df4747f7902fc85c7974e87e4e7c5d002893f56f59d0785dbf688353a232b8e0df5f578"} 07:34:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:34:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:34:59 INFO - Contents: 07:34:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/852e0f99129ce86f384d3a2226258317babe1acfddf77e19f4a792ba173ddff8c18981759e110c8b3b195d320a25f775ad439e937a21eb4511357f684bba100a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70e796e3726d59437a0e693e448f9a28a1f364a57a99cfd09e24c6417df4747f7902fc85c7974e87e4e7c5d002893f56f59d0785dbf688353a232b8e0df5f578"} 07:34:59 INFO - Running post-run listener: copy_logs_to_upload_dir 07:34:59 INFO - Copying logs to upload dir... 07:34:59 INFO - mkdir: /builds/slave/test/build/upload/logs 07:34:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.694091 ========= master_lag: 199.81 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 43 secs) (at 2016-04-29 07:38:19.765559) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-29 07:38:19.773570) ========= 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.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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/Fx-Team/sha512/852e0f99129ce86f384d3a2226258317babe1acfddf77e19f4a792ba173ddff8c18981759e110c8b3b195d320a25f775ad439e937a21eb4511357f684bba100a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70e796e3726d59437a0e693e448f9a28a1f364a57a99cfd09e24c6417df4747f7902fc85c7974e87e4e7c5d002893f56f59d0785dbf688353a232b8e0df5f578"} build_url:https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011580 build_url: 'https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/852e0f99129ce86f384d3a2226258317babe1acfddf77e19f4a792ba173ddff8c18981759e110c8b3b195d320a25f775ad439e937a21eb4511357f684bba100a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70e796e3726d59437a0e693e448f9a28a1f364a57a99cfd09e24c6417df4747f7902fc85c7974e87e4e7c5d002893f56f59d0785dbf688353a232b8e0df5f578"}' ========= master_lag: 3.60 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-29 07:38:23.389645) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 07:38:23.390070) ========= 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.QYeEyqL3Gx/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.KmmMVcv0Ve/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.005183 ========= master_lag: 1.89 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 07:38:25.284495) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 07:38:25.284813) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 07:38:25.458701) ========= ========= Total master_lag: 205.39 =========