builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0095 starttime: 1461349788.97 results: success (0) buildid: 20160422094408 builduid: da5f317903874936a4869d73f4e3343a revision: e086812341563534fb85964abda7effdcca09e1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 11:29:48.970644) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 11:29:48.971159) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 11:29:48.971494) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 11:29:49.015840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:29:49.016167) ========= 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.GwceeB7Z1i/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.XgKuWNiclA/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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-22 11:29:49-- 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% 29.6M=0s 2016-04-22 11:29:49 (29.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102691 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:29:49.302395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:29:49.302717) ========= 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.GwceeB7Z1i/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.XgKuWNiclA/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.028172 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:29:49.346383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 11:29:49.346745) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e086812341563534fb85964abda7effdcca09e1c --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 e086812341563534fb85964abda7effdcca09e1c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GwceeB7Z1i/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.XgKuWNiclA/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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-22 11:29:49,589 truncating revision to first 12 chars 2016-04-22 11:29:49,589 Setting DEBUG logging. 2016-04-22 11:29:49,589 attempt 1/10 2016-04-22 11:29:49,589 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e08681234156?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 11:29:51,166 unpacking tar archive at: fx-team-e08681234156/testing/mozharness/ program finished with exit code 0 elapsedTime=1.822469 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 11:29:51.186601) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 11:29:51.186999) ========= script_repo_revision: e086812341563534fb85964abda7effdcca09e1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 11:29:51.187480) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 11:29:51.187798) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 11:29:51.201777) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-04-22 11:29:51.202206) ========= /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.GwceeB7Z1i/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.XgKuWNiclA/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 11:29:51 INFO - MultiFileLogger online at 20160422 11:29:51 in /builds/slave/test 11:29:51 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 11:29:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:29:51 INFO - {'append_to_log': False, 11:29:51 INFO - 'base_work_dir': '/builds/slave/test', 11:29:51 INFO - 'blob_upload_branch': 'Fx-Team', 11:29:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:29:51 INFO - 'branch': 'Fx-Team', 11:29:51 INFO - 'buildbot_json_path': 'buildprops.json', 11:29:51 INFO - 'config_files': ('talos/mac_config.py',), 11:29:51 INFO - 'default_actions': ('clobber', 11:29:51 INFO - 'read-buildbot-config', 11:29:51 INFO - 'download-and-extract', 11:29:51 INFO - 'populate-webroot', 11:29:51 INFO - 'create-virtualenv', 11:29:51 INFO - 'install', 11:29:51 INFO - 'run-tests'), 11:29:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:29:51 INFO - 'download_minidump_stackwalk': True, 11:29:51 INFO - 'download_symbols': 'ondemand', 11:29:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:29:51 INFO - 'tooltool.py': '/tools/tooltool.py', 11:29:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:29:51 INFO - '/tools/misc-python/virtualenv.py')}, 11:29:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:29:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:29:51 INFO - 'installer_path': 'installer.exe', 11:29:51 INFO - 'log_level': 'info', 11:29:51 INFO - 'log_name': 'talos', 11:29:51 INFO - 'log_to_console': True, 11:29:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:29:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:29:51 INFO - 'opt_config_files': (), 11:29:51 INFO - 'pip_index': False, 11:29:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:29:51 INFO - 'cmd': ('bash', 11:29:51 INFO - '-c', 11:29:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:29:51 INFO - 'enabled': True, 11:29:51 INFO - 'halt_on_failure': False, 11:29:51 INFO - 'name': 'check_screen_resolution'},), 11:29:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:29:51 INFO - 'cmd': ('bash', 11:29:51 INFO - '-c', 11:29:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:29:51 INFO - 'enabled': True, 11:29:51 INFO - 'halt_on_failure': False, 11:29:51 INFO - 'name': 'check_screen_resolution'},), 11:29:51 INFO - 'run_cmd_checks_enabled': True, 11:29:51 INFO - 'sps_profile': False, 11:29:51 INFO - 'sps_profile_interval': 0, 11:29:51 INFO - 'suite': 'dromaeojs', 11:29:51 INFO - 'system_bits': '32', 11:29:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:29:51 INFO - 'title': 't-yosemite-r7-0095', 11:29:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:29:51 INFO - 'use_talos_json': True, 11:29:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:29:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:29:51 INFO - 'work_dir': 'build'} 11:29:51 INFO - ##### 11:29:51 INFO - ##### Running clobber step. 11:29:51 INFO - ##### 11:29:51 INFO - Running pre-action listener: _resource_record_pre_action 11:29:51 INFO - Running main action method: clobber 11:29:51 INFO - rmtree: /builds/slave/test/build 11:29:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:29:53 INFO - Running post-action listener: _resource_record_post_action 11:29:53 INFO - ##### 11:29:53 INFO - ##### Running read-buildbot-config step. 11:29:53 INFO - ##### 11:29:53 INFO - Running pre-action listener: _resource_record_pre_action 11:29:53 INFO - Running main action method: read_buildbot_config 11:29:53 INFO - Using buildbot properties: 11:29:53 INFO - { 11:29:53 INFO - "project": "", 11:29:53 INFO - "product": "firefox", 11:29:53 INFO - "script_repo_revision": "production", 11:29:53 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:29:53 INFO - "repository": "", 11:29:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:29:53 INFO - "buildid": "20160422094408", 11:29:53 INFO - "pgo_build": "False", 11:29:53 INFO - "basedir": "/builds/slave/test", 11:29:53 INFO - "buildnumber": 706, 11:29:53 INFO - "slavename": "t-yosemite-r7-0095", 11:29:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:29:53 INFO - "platform": "yosemite_r7", 11:29:53 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:29:53 INFO - "branch": "fx-team", 11:29:53 INFO - "repo_path": "integration/fx-team", 11:29:53 INFO - "revision": "e086812341563534fb85964abda7effdcca09e1c", 11:29:53 INFO - "stage_platform": "macosx64", 11:29:53 INFO - "builduid": "da5f317903874936a4869d73f4e3343a", 11:29:53 INFO - "slavebuilddir": "test" 11:29:53 INFO - } 11:29:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 11:29:53 INFO - Running post-action listener: _resource_record_post_action 11:29:53 INFO - ##### 11:29:53 INFO - ##### Running download-and-extract step. 11:29:53 INFO - ##### 11:29:53 INFO - Running pre-action listener: _resource_record_pre_action 11:29:53 INFO - Running main action method: download_and_extract 11:29:53 INFO - mkdir: /builds/slave/test/build/tests 11:29:53 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')]} 11:29:53 INFO - https://queue.taskcluster.net/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:29:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:29:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:29:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:29:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 11:29:54 INFO - Downloaded 1199 bytes. 11:29:54 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:29:54 INFO - Using the following test package requirements: 11:29:54 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:29:54 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:29:54 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 11:29:54 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:29:54 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 11:29:54 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:29:54 INFO - u'jsshell-mac.zip'], 11:29:54 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:29:54 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 11:29:54 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:29:54 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:29:54 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 11:29:54 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:29:54 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 11:29:54 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:29:54 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 11:29:54 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:29:54 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 11:29:54 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:54 INFO - https://queue.taskcluster.net/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:29:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:29:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:29:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:29:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:29:55 INFO - Downloaded 18109581 bytes. 11:29:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:29:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:29:58 INFO - Return code: 0 11:29:58 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:29:58 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')]} 11:29:58 INFO - https://queue.taskcluster.net/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:29:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:29:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:29:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:29:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:29:59 INFO - Downloaded 18109581 bytes. 11:29:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:29:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:30:03 INFO - Return code: 0 11:30:03 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')]} 11:30:03 INFO - https://queue.taskcluster.net/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:30:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:30:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:30:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:30:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:30:04 INFO - Downloaded 10840145 bytes. 11:30:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:30:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:30:04 INFO - Return code: 0 11:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:04 INFO - https://queue.taskcluster.net/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:30:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:30:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:30:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 11:30:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 11:30:14 INFO - Downloaded 110121150 bytes. 11:30:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:30:14 INFO - mkdir: /builds/slave/test/properties 11:30:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:30:14 INFO - Writing to file /builds/slave/test/properties/build_url 11:30:14 INFO - Contents: 11:30:14 INFO - build_url:https://queue.taskcluster.net/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:30:15 INFO - Running post-action listener: _resource_record_post_action 11:30:15 INFO - Running post-action listener: set_extra_try_arguments 11:30:15 INFO - ##### 11:30:15 INFO - ##### Running populate-webroot step. 11:30:15 INFO - ##### 11:30:15 INFO - Running pre-action listener: _resource_record_pre_action 11:30:15 INFO - Running main action method: populate_webroot 11:30:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:30:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:30:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:30:15 INFO - '--tppagecycles', 11:30:15 INFO - '7'], 11:30:15 INFO - 'tests': ['tsvgm']}}, 11:30:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:30:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:30:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:30:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:30:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:30:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:30:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:15 INFO - 'talos_options': ['--disable-e10s'], 11:30:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:15 INFO - 'talos_options': ['--disable-e10s'], 11:30:15 INFO - 'tests': ['damp', 'tps']}, 11:30:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:15 INFO - 'tests': ['damp', 'tps']}, 11:30:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:30:15 INFO - 'tests': ['dromaeo_dom']}, 11:30:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:30:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:30:15 INFO - 'tests': ['a11yr', 11:30:15 INFO - 'ts_paint', 11:30:15 INFO - 'tpaint', 11:30:15 INFO - 'sessionrestore', 11:30:15 INFO - 'sessionrestore_no_auto_restore', 11:30:15 INFO - 'tabpaint']}, 11:30:15 INFO - 'other-e10s': {'tests': ['a11yr', 11:30:15 INFO - 'ts_paint', 11:30:15 INFO - 'tpaint', 11:30:15 INFO - 'sessionrestore', 11:30:15 INFO - 'sessionrestore_no_auto_restore', 11:30:15 INFO - 'tabpaint']}, 11:30:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:30:15 INFO - 'ts_paint', 11:30:15 INFO - 'tpaint', 11:30:15 INFO - 'sessionrestore', 11:30:15 INFO - 'sessionrestore_no_auto_restore', 11:30:15 INFO - 'tabpaint']}, 11:30:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:30:15 INFO - 'ts_paint', 11:30:15 INFO - 'tpaint', 11:30:15 INFO - 'sessionrestore', 11:30:15 INFO - 'sessionrestore_no_auto_restore', 11:30:15 INFO - 'tabpaint']}, 11:30:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:30:15 INFO - 'tests': ['a11yr', 11:30:15 INFO - 'ts_paint', 11:30:15 INFO - 'tpaint', 11:30:15 INFO - 'sessionrestore', 11:30:15 INFO - 'sessionrestore_no_auto_restore', 11:30:15 INFO - 'tabpaint']}, 11:30:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:30:15 INFO - 'tests': ['a11yr', 11:30:15 INFO - 'ts_paint', 11:30:15 INFO - 'tpaint', 11:30:15 INFO - 'sessionrestore', 11:30:15 INFO - 'sessionrestore_no_auto_restore', 11:30:15 INFO - 'tabpaint']}, 11:30:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:30:15 INFO - 'tests': ['tsvgx', 11:30:15 INFO - 'tsvgr_opacity', 11:30:15 INFO - 'tart', 11:30:15 INFO - 'tscrollx', 11:30:15 INFO - 'cart']}, 11:30:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:30:15 INFO - 'tsvgr_opacity', 11:30:15 INFO - 'tart', 11:30:15 INFO - 'tscrollx', 11:30:15 INFO - 'cart']}, 11:30:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:15 INFO - 'talos_options': ['--disable-e10s'], 11:30:15 INFO - 'tests': ['tp5o']}, 11:30:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:15 INFO - 'tests': ['tp5o']}, 11:30:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:15 INFO - 'talos_options': ['--disable-e10s', 11:30:15 INFO - '--xperf_path', 11:30:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:15 INFO - 'tests': ['tp5n']}, 11:30:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:15 INFO - 'talos_options': ['--xperf_path', 11:30:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:15 INFO - 'tests': ['tp5n']}}, 11:30:15 INFO - 'talos.zip': {'path': '', 11:30:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:30:15 INFO - Running post-action listener: _resource_record_post_action 11:30:15 INFO - ##### 11:30:15 INFO - ##### Running create-virtualenv step. 11:30:15 INFO - ##### 11:30:15 INFO - Running pre-action listener: _resource_record_pre_action 11:30:15 INFO - Running main action method: create_virtualenv 11:30:15 INFO - Creating virtualenv /builds/slave/test/build/venv 11:30:15 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 11:30:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:30:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:30:15 INFO - Using real prefix '/tools/python27' 11:30:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:30:16 INFO - Installing distribute.............................................................................................................................................................................................done. 11:30:19 INFO - Installing pip.................done. 11:30:19 INFO - Return code: 0 11:30:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:19 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 0x10c4cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf0d57c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ce00>, '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 0x10c195db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c367b20>, '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.GwceeB7Z1i/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.XgKuWNiclA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 11:30:19 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 11:30:19 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 11:30:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwceeB7Z1i/Render', 11:30:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:30:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:30:19 INFO - 'HOME': '/Users/cltbld', 11:30:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:30:19 INFO - 'LOGNAME': 'cltbld', 11:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:19 INFO - 'MOZ_NO_REMOTE': '1', 11:30:19 INFO - 'NO_EM_RESTART': '1', 11:30:19 INFO - 'PAGER': '/bin/cat', 11:30:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:19 INFO - 'PWD': '/builds/slave/test', 11:30:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:30:19 INFO - 'SHELL': '/bin/bash', 11:30:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XgKuWNiclA/Listeners', 11:30:19 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 11:30:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:30:19 INFO - 'USER': 'cltbld', 11:30:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:30:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:19 INFO - 'XPC_FLAGS': '0x0', 11:30:19 INFO - 'XPC_SERVICE_NAME': '0', 11:30:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:19 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 11:30:19 INFO - Cleaning up... 11:30:19 INFO - Return code: 0 11:30:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:19 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 0x10c4cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf0d57c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ce00>, '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 0x10c195db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c367b20>, '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.GwceeB7Z1i/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.XgKuWNiclA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 11:30:19 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 11:30:19 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 11:30:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwceeB7Z1i/Render', 11:30:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:30:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:30:19 INFO - 'HOME': '/Users/cltbld', 11:30:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:30:19 INFO - 'LOGNAME': 'cltbld', 11:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:19 INFO - 'MOZ_NO_REMOTE': '1', 11:30:19 INFO - 'NO_EM_RESTART': '1', 11:30:19 INFO - 'PAGER': '/bin/cat', 11:30:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:19 INFO - 'PWD': '/builds/slave/test', 11:30:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:30:19 INFO - 'SHELL': '/bin/bash', 11:30:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XgKuWNiclA/Listeners', 11:30:19 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 11:30:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:30:19 INFO - 'USER': 'cltbld', 11:30:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:30:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:19 INFO - 'XPC_FLAGS': '0x0', 11:30:19 INFO - 'XPC_SERVICE_NAME': '0', 11:30:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:19 INFO - Downloading/unpacking psutil>=0.7.1 11:30:19 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 11:30:19 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 11:30:19 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 11:30:19 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 11:30:19 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 11:30:19 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 11:30:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:30:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:22 INFO - Installing collected packages: psutil 11:30:22 INFO - Running setup.py install for psutil 11:30:22 INFO - building 'psutil._psutil_osx' extension 11:30:22 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 11:30:23 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 11:30:23 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 11:30:23 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 11:30:23 INFO - building 'psutil._psutil_posix' extension 11:30:23 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 11:30:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:30:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:30:23 INFO - ^ 11:30:23 INFO - 1 warning generated. 11:30:23 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 11:30:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:23 INFO - Successfully installed psutil 11:30:23 INFO - Cleaning up... 11:30:23 INFO - Return code: 0 11:30:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:23 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 0x10c4cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf0d57c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ce00>, '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 0x10c195db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c367b20>, '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.GwceeB7Z1i/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.XgKuWNiclA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 11:30:23 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 11:30:23 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 11:30:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwceeB7Z1i/Render', 11:30:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:30:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:30:23 INFO - 'HOME': '/Users/cltbld', 11:30:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:30:23 INFO - 'LOGNAME': 'cltbld', 11:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:23 INFO - 'MOZ_NO_REMOTE': '1', 11:30:23 INFO - 'NO_EM_RESTART': '1', 11:30:23 INFO - 'PAGER': '/bin/cat', 11:30:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:23 INFO - 'PWD': '/builds/slave/test', 11:30:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:30:23 INFO - 'SHELL': '/bin/bash', 11:30:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XgKuWNiclA/Listeners', 11:30:23 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 11:30:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:30:23 INFO - 'USER': 'cltbld', 11:30:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:30:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:23 INFO - 'XPC_FLAGS': '0x0', 11:30:23 INFO - 'XPC_SERVICE_NAME': '0', 11:30:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:30:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:30:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:30:26 INFO - Installing collected packages: mozsystemmonitor 11:30:26 INFO - Running setup.py install for mozsystemmonitor 11:30:26 INFO - Successfully installed mozsystemmonitor 11:30:26 INFO - Cleaning up... 11:30:26 INFO - Return code: 0 11:30:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:30:26 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')]} 11:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:26 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')]} 11:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:26 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 0x10c4cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf0d57c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ce00>, '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 0x10c195db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c367b20>, '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.GwceeB7Z1i/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.XgKuWNiclA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 11:30:26 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 11:30:26 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 11:30:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwceeB7Z1i/Render', 11:30:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:30:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:30:26 INFO - 'HOME': '/Users/cltbld', 11:30:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:30:26 INFO - 'LOGNAME': 'cltbld', 11:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:26 INFO - 'MOZ_NO_REMOTE': '1', 11:30:26 INFO - 'NO_EM_RESTART': '1', 11:30:26 INFO - 'PAGER': '/bin/cat', 11:30:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:26 INFO - 'PWD': '/builds/slave/test', 11:30:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:30:26 INFO - 'SHELL': '/bin/bash', 11:30:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XgKuWNiclA/Listeners', 11:30:26 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 11:30:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:30:26 INFO - 'USER': 'cltbld', 11:30:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:30:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:26 INFO - 'XPC_FLAGS': '0x0', 11:30:26 INFO - 'XPC_SERVICE_NAME': '0', 11:30:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:27 INFO - Downloading/unpacking blobuploader==1.2.4 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30:29 INFO - Downloading blobuploader-1.2.4.tar.gz 11:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:30:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:30:29 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 11:30:29 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 11:30:29 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 11:30:29 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 11:30:29 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 11:30:29 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 11:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:30:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:30 INFO - Downloading docopt-0.6.1.tar.gz 11:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:30:30 INFO - Installing collected packages: blobuploader, requests, docopt 11:30:30 INFO - Running setup.py install for blobuploader 11:30:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:30:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:30:30 INFO - Running setup.py install for requests 11:30:31 INFO - Running setup.py install for docopt 11:30:31 INFO - Successfully installed blobuploader requests docopt 11:30:31 INFO - Cleaning up... 11:30:31 INFO - Return code: 0 11:30:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:30:31 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')]} 11:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:31 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')]} 11:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:31 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 0x10c4cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf0d57c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ce00>, '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 0x10c195db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c367b20>, '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.GwceeB7Z1i/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.XgKuWNiclA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 11:30:31 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 11:30:31 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 11:30:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwceeB7Z1i/Render', 11:30:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:30:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:30:31 INFO - 'HOME': '/Users/cltbld', 11:30:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:30:31 INFO - 'LOGNAME': 'cltbld', 11:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:31 INFO - 'MOZ_NO_REMOTE': '1', 11:30:31 INFO - 'NO_EM_RESTART': '1', 11:30:31 INFO - 'PAGER': '/bin/cat', 11:30:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:31 INFO - 'PWD': '/builds/slave/test', 11:30:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:30:31 INFO - 'SHELL': '/bin/bash', 11:30:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XgKuWNiclA/Listeners', 11:30:31 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 11:30:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:30:31 INFO - 'USER': 'cltbld', 11:30:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:30:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:31 INFO - 'XPC_FLAGS': '0x0', 11:30:31 INFO - 'XPC_SERVICE_NAME': '0', 11:30:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:30:31 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-e06JU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:30:31 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Q_j74j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:30:32 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-1c4XVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:30:32 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-AgbFSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:30:32 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-iVdDD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:30:32 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-6X94r3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:30:32 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-vtzfVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:30:32 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-H0Pegv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:30:32 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-OMAViq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:30:32 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-MdV465-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:30:32 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-47AA6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:30:33 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-HcAuog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:30:33 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-16BHDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:30:33 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-8C851L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:30:33 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-gsQp1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:30:33 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-4lYZZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:30:33 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-toYQJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:30:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:30:33 INFO - Running setup.py install for manifestparser 11:30:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:30:33 INFO - Running setup.py install for mozcrash 11:30:33 INFO - Running setup.py install for mozdebug 11:30:34 INFO - Running setup.py install for mozdevice 11:30:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:30:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:30:34 INFO - Running setup.py install for mozfile 11:30:34 INFO - Running setup.py install for mozhttpd 11:30:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:30:34 INFO - Running setup.py install for mozinfo 11:30:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:30:34 INFO - Running setup.py install for mozInstall 11:30:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:30:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:30:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:30:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:30:34 INFO - Running setup.py install for mozleak 11:30:34 INFO - Running setup.py install for mozlog 11:30:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:30:35 INFO - Running setup.py install for moznetwork 11:30:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:30:35 INFO - Running setup.py install for mozprocess 11:30:35 INFO - Running setup.py install for mozprofile 11:30:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:30:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:30:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:30:35 INFO - Running setup.py install for mozrunner 11:30:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:30:35 INFO - Running setup.py install for mozscreenshot 11:30:35 INFO - Running setup.py install for moztest 11:30:36 INFO - Running setup.py install for mozversion 11:30:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:30:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:30:36 INFO - Cleaning up... 11:30:36 INFO - Return code: 0 11:30:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:30:36 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')]} 11:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:36 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')]} 11:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:36 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 0x10c4cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf0d57c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ce00>, '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 0x10c195db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c367b20>, '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.GwceeB7Z1i/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.XgKuWNiclA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 11:30:36 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 11:30:36 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 11:30:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwceeB7Z1i/Render', 11:30:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:30:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:30:36 INFO - 'HOME': '/Users/cltbld', 11:30:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:30:36 INFO - 'LOGNAME': 'cltbld', 11:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:36 INFO - 'MOZ_NO_REMOTE': '1', 11:30:36 INFO - 'NO_EM_RESTART': '1', 11:30:36 INFO - 'PAGER': '/bin/cat', 11:30:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:36 INFO - 'PWD': '/builds/slave/test', 11:30:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:30:36 INFO - 'SHELL': '/bin/bash', 11:30:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XgKuWNiclA/Listeners', 11:30:36 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 11:30:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:30:36 INFO - 'USER': 'cltbld', 11:30:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:30:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:36 INFO - 'XPC_FLAGS': '0x0', 11:30:36 INFO - 'XPC_SERVICE_NAME': '0', 11:30:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:30:36 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-DvrbzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:30:36 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)) 11:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:30:36 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-ajqN02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:30:36 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)) 11:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:30:36 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-SarMRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:30:36 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)) 11:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:30:36 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-AmnRpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:30:36 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)) 11:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:30:36 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-MIhTDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:30:36 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)) 11:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:30:36 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-9ZOtjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:30:37 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-QMbGh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:30:37 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-lcOg7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:30:37 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-gu27xL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:30:37 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-grYmju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:30:37 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-SaqSB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:30:37 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-wVc2g5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:30:37 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Hk9rW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:30:37 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-KomCTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:30:37 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-KqMFRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:30:38 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)) 11:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:30:38 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-TDeibf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:30:38 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)) 11:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:30:38 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-RSvzY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:30:38 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)) 11:30:38 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)) 11:30:38 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)) 11:30:38 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)) 11:30:38 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)) 11:30:38 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)) 11:30:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:30:38 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 11:30:38 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 11:30:38 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 11:30:38 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 11:30:38 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 11:30:38 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 11:30:41 INFO - Downloading blessings-1.6.tar.gz 11:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:30:41 INFO - Installing collected packages: blessings 11:30:41 INFO - Running setup.py install for blessings 11:30:41 INFO - Successfully installed blessings 11:30:41 INFO - Cleaning up... 11:30:41 INFO - Return code: 0 11:30:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:30:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:30:41 INFO - Reading from file tmpfile_stdout 11:30:41 INFO - Current package versions: 11:30:41 INFO - blessings == 1.6 11:30:41 INFO - blobuploader == 1.2.4 11:30:41 INFO - docopt == 0.6.1 11:30:41 INFO - manifestparser == 1.1 11:30:41 INFO - mozInstall == 1.12 11:30:41 INFO - mozcrash == 0.17 11:30:41 INFO - mozdebug == 0.1 11:30:41 INFO - mozdevice == 0.48 11:30:41 INFO - mozfile == 1.2 11:30:41 INFO - mozhttpd == 0.7 11:30:41 INFO - mozinfo == 0.9 11:30:41 INFO - mozleak == 0.1 11:30:41 INFO - mozlog == 3.1 11:30:41 INFO - moznetwork == 0.27 11:30:41 INFO - mozprocess == 0.22 11:30:41 INFO - mozprofile == 0.28 11:30:41 INFO - mozrunner == 6.11 11:30:41 INFO - mozscreenshot == 0.1 11:30:41 INFO - mozsystemmonitor == 0.0 11:30:41 INFO - moztest == 0.7 11:30:41 INFO - mozversion == 1.4 11:30:41 INFO - psutil == 3.1.1 11:30:41 INFO - requests == 1.2.3 11:30:41 INFO - wsgiref == 0.1.2 11:30:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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')]} 11:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:42 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 0x10c4cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf0d57c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ce00>, '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 0x10c195db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c367b20>, '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.GwceeB7Z1i/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.XgKuWNiclA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 11:30:42 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 11:30:42 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 11:30:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwceeB7Z1i/Render', 11:30:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:30:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:30:42 INFO - 'HOME': '/Users/cltbld', 11:30:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:30:42 INFO - 'LOGNAME': 'cltbld', 11:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:42 INFO - 'MOZ_NO_REMOTE': '1', 11:30:42 INFO - 'NO_EM_RESTART': '1', 11:30:42 INFO - 'PAGER': '/bin/cat', 11:30:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:42 INFO - 'PWD': '/builds/slave/test', 11:30:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:30:42 INFO - 'SHELL': '/bin/bash', 11:30:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XgKuWNiclA/Listeners', 11:30:42 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 11:30:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:30:42 INFO - 'USER': 'cltbld', 11:30:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:30:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:42 INFO - 'XPC_FLAGS': '0x0', 11:30:42 INFO - 'XPC_SERVICE_NAME': '0', 11:30:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:42 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)) 11:30:42 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)) 11:30:42 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)) 11:30:42 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)) 11:30:42 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)) 11:30:42 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)) 11:30:42 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)) 11:30:42 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)) 11:30:42 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)) 11:30:42 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)) 11:30:42 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)) 11:30:42 INFO - Cleaning up... 11:30:42 INFO - Return code: 0 11:30:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:30: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')]} 11:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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')]} 11:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf0d57c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ce00>, '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 0x10c195db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c367b20>, '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.GwceeB7Z1i/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.XgKuWNiclA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 11:30: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', 'jsonschema'] in /builds/slave/test/build 11:30: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 jsonschema 11:30:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwceeB7Z1i/Render', 11:30:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:30:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:30:42 INFO - 'HOME': '/Users/cltbld', 11:30:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:30:42 INFO - 'LOGNAME': 'cltbld', 11:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:42 INFO - 'MOZ_NO_REMOTE': '1', 11:30:42 INFO - 'NO_EM_RESTART': '1', 11:30:42 INFO - 'PAGER': '/bin/cat', 11:30:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:42 INFO - 'PWD': '/builds/slave/test', 11:30:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:30:42 INFO - 'SHELL': '/bin/bash', 11:30:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XgKuWNiclA/Listeners', 11:30:42 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 11:30:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:30:42 INFO - 'USER': 'cltbld', 11:30:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:30:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:42 INFO - 'XPC_FLAGS': '0x0', 11:30:42 INFO - 'XPC_SERVICE_NAME': '0', 11:30:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:42 INFO - Downloading/unpacking jsonschema 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:30:44 INFO - Downloading/unpacking functools32 (from jsonschema) 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30:45 INFO - Downloading functools32-3.2.3-2.tar.gz 11:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:30:45 INFO - warning: no files found matching '*.txt' 11:30:45 INFO - no previously-included directories found matching 'build' 11:30:45 INFO - no previously-included directories found matching 'dist' 11:30:45 INFO - no previously-included directories found matching '.git*' 11:30:45 INFO - Installing collected packages: jsonschema, functools32 11:30:45 INFO - Running setup.py install for functools32 11:30:45 INFO - warning: no files found matching '*.txt' 11:30:45 INFO - no previously-included directories found matching 'build' 11:30:45 INFO - no previously-included directories found matching 'dist' 11:30:45 INFO - no previously-included directories found matching '.git*' 11:30:45 INFO - Successfully installed jsonschema functools32 11:30:45 INFO - Cleaning up... 11:30:45 INFO - Return code: 0 11:30:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf0d57c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c36ce00>, '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 0x10c195db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c367b20>, '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.GwceeB7Z1i/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.XgKuWNiclA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 11:30:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:30:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwceeB7Z1i/Render', 11:30:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:30:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:30:45 INFO - 'HOME': '/Users/cltbld', 11:30:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:30:45 INFO - 'LOGNAME': 'cltbld', 11:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:45 INFO - 'MOZ_NO_REMOTE': '1', 11:30:45 INFO - 'NO_EM_RESTART': '1', 11:30:45 INFO - 'PAGER': '/bin/cat', 11:30:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:45 INFO - 'PWD': '/builds/slave/test', 11:30:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:30:45 INFO - 'SHELL': '/bin/bash', 11:30:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XgKuWNiclA/Listeners', 11:30:45 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 11:30:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:30:45 INFO - 'USER': 'cltbld', 11:30:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:30:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:45 INFO - 'XPC_FLAGS': '0x0', 11:30:45 INFO - 'XPC_SERVICE_NAME': '0', 11:30:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:45 INFO - Downloading/unpacking flake8 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:30:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:30:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:30:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:30:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:30:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:30:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:30:49 INFO - no previously-included directories found matching 'docs/_build' 11:30:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:30:49 INFO - Running setup.py install for pep8 11:30:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:30:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:30:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:30:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:30:49 INFO - no previously-included directories found matching 'docs/_build' 11:30:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:30:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:30:49 INFO - Cleaning up... 11:30:49 INFO - Return code: 0 11:30:49 INFO - Running post-action listener: _resource_record_post_action 11:30:49 INFO - Running post-action listener: _start_resource_monitoring 11:30:49 INFO - Starting resource monitoring. 11:30:49 INFO - ##### 11:30:49 INFO - ##### Running install step. 11:30:49 INFO - ##### 11:30:49 INFO - Running pre-action listener: _resource_record_pre_action 11:30:49 INFO - Running main action method: install 11:30:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:30:50 INFO - Reading from file tmpfile_stdout 11:30:50 INFO - Detecting whether we're running mozinstall >=1.0... 11:30:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:30:50 INFO - Reading from file tmpfile_stdout 11:30:50 INFO - Output received: 11:30:50 INFO - Usage: mozinstall [options] installer 11:30:50 INFO - Options: 11:30:50 INFO - -h, --help show this help message and exit 11:30:50 INFO - -d DEST, --destination=DEST 11:30:50 INFO - Directory to install application into. [default: 11:30:50 INFO - "/builds/slave/test"] 11:30:50 INFO - --app=APP Application being installed. [default: firefox] 11:30:50 INFO - mkdir: /builds/slave/test/build/application 11:30:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:31:23 INFO - Reading from file tmpfile_stdout 11:31:23 INFO - Output received: 11:31:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:31:23 INFO - Running post-action listener: _resource_record_post_action 11:31:23 INFO - ##### 11:31:23 INFO - ##### Running run-tests step. 11:31:23 INFO - ##### 11:31:23 INFO - Running pre-action listener: _resource_record_pre_action 11:31:23 INFO - Running main action method: run_tests 11:31:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:31:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:31:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:31:23 INFO - 2016-04-22 11:31:23.644 screenresolution[1640:7565] starting screenresolution argv=screenresolution get 11:31:23 INFO - 2016-04-22 11:31:23.646 screenresolution[1640:7565] Display 0: 1600x1200x32@60 11:31:23 INFO - 2016-04-22 11:31:23.652 screenresolution[1641:7567] starting screenresolution argv=screenresolution list 11:31:23 INFO - Available Modes on Display 0 11:31:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:31:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:31:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:31:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:31:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:31:23 INFO - Intel Iris: 11:31:23 INFO - Chipset Model: Intel Iris 11:31:23 INFO - Type: GPU 11:31:23 INFO - Bus: Built-In 11:31:23 INFO - VRAM (Dynamic, Max): 1536 MB 11:31:23 INFO - Vendor: Intel (0x8086) 11:31:23 INFO - Device ID: 0x0a2e 11:31:23 INFO - Revision ID: 0x0009 11:31:23 INFO - Displays: 11:31:23 INFO - Display: 11:31:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:31:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:31:23 INFO - Display Serial Number: 1600x1200 60 11:31:23 INFO - Main Display: Yes 11:31:23 INFO - Mirror: Off 11:31:23 INFO - Online: Yes 11:31:23 INFO - Rotation: Supported 11:31:23 INFO - Return code: 0 11:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:31:23 INFO - Python 2.7.3 11:31:23 INFO - Return code: 0 11:31:23 INFO - grabbing minidump binary from tooltool 11:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:23 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 0x10c36ce00>, '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 0x10c195db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c367b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:31:23 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 11:31:23 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 11:31:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:31:23 INFO - Return code: 0 11:31:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:31:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:31:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:31:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:31:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:31:25 INFO - Return code: 0 11:31:25 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/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0095', '--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 11:31:25 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/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0095 --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 11:31:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwceeB7Z1i/Render', 11:31:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:31:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:31:25 INFO - 'HOME': '/Users/cltbld', 11:31:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:31:25 INFO - 'LOGNAME': 'cltbld', 11:31:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:31:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:25 INFO - 'MOZ_NO_REMOTE': '1', 11:31:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:31:25 INFO - 'NO_EM_RESTART': '1', 11:31:25 INFO - 'PAGER': '/bin/cat', 11:31:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:25 INFO - 'PWD': '/builds/slave/test', 11:31:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:31:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:31:25 INFO - 'SHELL': '/bin/bash', 11:31:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XgKuWNiclA/Listeners', 11:31:25 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 11:31:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:31:25 INFO - 'USER': 'cltbld', 11:31:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:31:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:25 INFO - 'XPC_FLAGS': '0x0', 11:31:25 INFO - 'XPC_SERVICE_NAME': '0', 11:31:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:31:25 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/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0095', '--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 11:31:25 INFO - mozversion application_buildid: 20160422094408 11:31:25 INFO - mozversion application_changeset: e086812341563534fb85964abda7effdcca09e1c 11:31:25 INFO - mozversion application_display_name: Nightly 11:31:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:31:25 INFO - mozversion application_name: Firefox 11:31:25 INFO - mozversion application_remotingname: firefox 11:31:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:31:25 INFO - mozversion application_vendor: Mozilla 11:31:25 INFO - mozversion application_version: 48.0a1 11:31:25 INFO - mozversion platform_buildid: 20160422094408 11:31:25 INFO - mozversion platform_changeset: e086812341563534fb85964abda7effdcca09e1c 11:31:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:31:25 INFO - mozversion platform_version: 48.0a1 11:31:25 INFO - using testdate: 1461349885 11:31:25 INFO - actual date: 1461349885 11:31:25 INFO - starting webserver on 'localhost:49275' 11:31:25 INFO - SUITE-START | Running 2 tests 11:31:25 INFO - TEST-START | dromaeo_css 11:31:25 INFO - operating with platform_type : mac_ 11:31:25 INFO - Initialising browser for dromaeo_css test... 11:31:25 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmp8TR2JY/profile http://localhost:49275/getInfo.html) 11:31:27 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 11:31:27 INFO - PROCESS | 1659 | colorDepth:24 11:31:27 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 11:31:27 INFO - PROCESS | 1659 | __metrics 11:31:27 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:31:27 ERROR - PROCESS | 1659 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:31:28 INFO - TEST-INFO | 1659: exit 0 11:31:28 INFO - Browser initialized. 11:31:28 INFO - Running cycle 1/1 for dromaeo_css test... 11:31:28 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmp8TR2JY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:40 INFO - PROCESS | 1661 | RSS: Main: 238977024 11:31:40 INFO - PROCESS | 1661 | 11:32:31 INFO - PROCESS | 1661 | 1461349951693 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] 11:34:42 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 11:34:43 INFO - PROCESS | 1661 | RSS: Main: 367112192 11:34:43 INFO - PROCESS | 1661 | 11:37:46 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 11:37:47 INFO - PROCESS | 1661 | RSS: Main: 379117568 11:37:47 INFO - PROCESS | 1661 | 11:40:49 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 11:40:49 INFO - PROCESS | 1661 | RSS: Main: 375996416 11:40:49 INFO - PROCESS | 1661 | 11:43:52 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 11:43:52 INFO - PROCESS | 1661 | RSS: Main: 374280192 11:43:52 INFO - PROCESS | 1661 | 11:46:55 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 11:46:56 INFO - PROCESS | 1661 | RSS: Main: 347455488 11:46:56 INFO - PROCESS | 1661 | 11:49:59 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 11:49:59 INFO - PROCESS | 1661 | RSS: Main: 415387648 11:49:59 INFO - PROCESS | 1661 | 11:49:59 INFO - PROCESS | 1661 | __start_tp_report 11:49:59 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 11:49:59 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 11:49:59 INFO - PROCESS | 1661 | |i|pagename|runs| 11:49:59 INFO - PROCESS | 1661 | |0;dojo.html;3074.6156730408698;3458.3602033623783;3479.5476588043553;3492.3189977954275;3511.947320790187;5622.269105016352;5665.688387138705;5695.772169113241;5710.457506536877;5719.256496655435;5678.801241956532;5728.68492232927;5754.769809207637;5815.709214539277;5899.970500147504;5160.509751573594;5172.172452407597;5209;5219.399769026572;5328.20076988451;5277.498637629438;5291.312129423189;5313.548348390392;5319.281896943921;5369.275147855048;5148.74256287186;5256.658317209369;5259.421463638997;5265.710385928773;5273.789048438058;5238.8690282742855;5258.737063146866;5262.60530460217;5269.314989051437;5276.604254680914;5176.896462070775;5190.688558686453;5231.973840130813;5232.895342093137;5245.737713114329;5587.55299576037;5610.270664813548;5617;5663.575231857627;5680.8863822723315;6123.862238009563;6143.2662465203;6219.222597175353;6243.906341404882;6275.497960163221;6205.627662340229;6287.402696743802;6310.6213627182515;6313.905291420632;6319.747210111636;4899.828506002308;5184.496496016151;5610.438956104438;5740.569457290637;5809.7966571170655;6207.937920620826;6230.937690623126;6268.09112678659;6276.403741644536;6300.054991751183;6164.383561643889;6175.96912015446;6189.6286222826775;6199.256089269316;6201.286852012076;6135.814547850636;6237.064440333987;6280.591761535486;6286.245650521967;6291.150694656254;6121.392004143319;6216.720247588779;6232;6237.09562113491;6244.500439964792;6239.313675495692;6249.625022498664;6252;6252.406021427957;6277.121203031579;4802.303665968415;4854.150523658345;4896.6572339935865;4920.5571498565305;4957.033378491232;4376.606105450461;4408.669349798778;4433.667474939392;4444.31113177458;4444.7110937789585;5533.114701647717;5574.275344205308;5576.665400076008;5594.272744543265;5599.1041433370465;6142.8057410146475;6145.324014358417;6146.7706458708435;6160.075988601746;6163.38366163389;5624.268845050117;5678.829635110953;5705.087186050295;5731.914021289684;5740.225069615549;5370.248165256867;5391.919121213185;5397.973010135002;5400.243965844785;5418.620696551204;5220.243064755589;6201.472874805692;6261.154744109669;6351.491880649537;6358.618482891041;6257.4681152102585;6308.968455157878;6313.842153946188;6315.652639104709;6318.115463835159;6322.209723784527;6333.050042493663;6349.111124442674;6364.299927008118;6380.489560835029;5139.768710407966;6075.210222671025;6118.832384214075;6124.5712800103565;6153.4154255345675;6257.468115210076;6274.560780745304;6281.937180628135;6295.244570651551;6319.24169099711;5197.948020519746;6053.303870055;6133.478654314434;6139.693015349304;6161.568690191643;5956.434138756811;6015.2781666200335;6107.511399087974;6109.816705498843;6125.356837531995;5302.496262855023;5677.8864422710485;5947.702614869153;5951.404859514014;5975.133605627247;6071.301800293023;6134;6143.801958618026;6148.077788331607;6150.661713605795;5748.856278592902;5902.970485147547;5906.645601263938;6015.428534289235;6024.608400453956 11:49:59 INFO - PROCESS | 1661 | |1;ext.html;525.1990714160902;537.5296615461472;555.2476394485469;574.9564540359248;604.2235727090689;31105;38392.80803595982;39641.20717585643;39728.205435891265;39878.401823972665;42363;43079.3538096928;43112.13775724483;43172.70481885548;43271.889170528746;8612.48325100493;9425.905740942588;9696.272779541527;9705.951470242639;9710.660126895526;8698.260647844909;8821.117888211193;8822.338324625647;8842.955785221066;11642.068634509262;11581.247218930785;11670.066394688447;11675.766484670345;11691.766164676701;11696.239744416585;11515.193936424412;11592.6522204334;11593.304401735923;11610.071194304477;11614.651560453116;8668.52323122228;8936.687215947411;8940.64237430502;8945;11518.308901465854;40516.39225411621;41436.964075898046;41462.79268603668;41582.633823448705;41720;3207.4386982278243;3311.2549676322874;3463.965360346415;3559.875404360835;3973.927039699294;27377.31556711078;27569.586456203175;27597.172084837486;27633.447331053267;27855.442891142266;2674.358154043035;2690.2870739254113;2698.3254186453387;2713.7150599187;2810.0726760169096;441295;442867;444694.7765261185;444934;445895;36484.08789780277;37511;62474;62926;63006;36394.45408318877;36471;36675.083122922144;36694.633053669124;36791.63208367882;15206.08763474195;15396;15402.46091386796;15412.46056388021;15437.536873893801;12931.5473958411;13005.943603253229;13006.934965325112;13019.804702929463;13020;7725.22747725223;7852.84294314122;8132.837343253102;8212.096669366365;8296.377771667148;2747.5603903375363;3166.859930425045;3343.4650455926935;3351.4470112431177;3379.6113446953914;902.4089221559889;1001.8228581416806;1061.7451811565168;1066.7279843639822;1113.9387333696725;29870.25324366865;29883.25291867677;30514.54228186579;30719.385612288075;30922;1066.8506409102731;1094.6223552874246;1102.862142232221;1104.2932523185168;1170.0054953289805;14558.927205363905;15568.455104071303;15580.00089717831;15884.126373049594;15907.0455772654;644282;650531;657579;658457;671100;60974;62013;62061;62125.68937155376;62408.06387904185;1332.5602551158095;1494.3648949196547;1501.7522108852136;1511.7203317386318;1554.7901033360579;27087.45825083527;28727.856360718062;29261.41477170402;29294.7070529292;29348.41303173882;49616;50139;50247.995040099726;50260.748696257746;50433;430896;436036.8198158989;438862;439796;439846;22751;27296.454070918866;27781.861090694416;27798;27867.303317417227;44313.77843110764;45469;45817.854553636425;46231;47701;37630.811845940596;37684.05789855166;37880.43179352367;38191.19048688407;38405.6159438402;33034.66965330316;34126;37430.62569374272;37636.05909852275;38129.42805857859;36644.63355366412;36726;36904;37401;37740.62259377371;32311.51532727058;32438.026859194262;32875.17812054718;32978.505322420664;33409.997700069034;21136;23320.599646913895;24404.63393049141;24671.259862204162;24880.004799807804 11:49:59 INFO - PROCESS | 1661 | |2;jquery.html;392.8958825911134;394.77497826239045;399.325140512534;402.2136722707108;410.4028638331228;13866;20001.999900005016;20656.48358791031;20766.89616551917;20776.584468310626;15908.284127214274;17277;19770.81375117494;20240.797592024075;20689.58620827586;5813.73838177282;5998.9700051499685;6020.939790602104;6033.185519954815;6033.818985430422;5684.886302273952;5895.734691938852;5906.4093590640805;5942.465178133967;5991.970040149815;5003.399592048941;5859.267591551056;5864.06175011996;5875.559333050017;5899.32157801854;5704.11586204139;5816.651000939957;5917.852053698649;5925.585209035369;5930.644161350289;5204.8178313758835;5219.295395121648;5220.791168353261;5221.1124108901195;5224.8693782655355;23650.172243971378;24708.382290442703;25841.483170336676;25897.870510647324;25922.351941201432;1780.3323753592404;2120.526234267185;2227.866328020324;2231.141010710872;2420.673209116764;12045.217060891102;14655.560333189915;14766.704665906622;14890.255487225595;15243.314050867737;1638.3200971596773;1672.4480921296065;1706.300416829094;1738.3568079810425;1760.2430954689478;114559;118496;119066;119207;121919;10400.323978941344;10822.296550724177;10860.294080884718;10869.619563315246;11096.223264371578;13600.115992460458;13696.178229306273;13723.862761372258;13732.107413018322;13741.931290343684;6865.9313406866295;7082.433405327562;7219.60292183935;8021.598920053974;8540.615672294762;8392.328613710888;8586.797848301243;8617.526036067951;8735.65057397697;8763.386562940534;5327.7336133193185;6357.205349331333;6479.222493300834;6487.902681459782;6565.770198043046;1600.8639265662316;1849.6115815678588;1883.2561138350275;1887.1507821480388;1889.9055047247857;889.3907673243849;925.6300675001036;957.2581249531669;1039.8561582259606;1040.1003132290514;16073.598160046093;20582.485437864172;20712.99661549067;20768.169273229203;21293;868.3140319147928;915.2769312243387;931.4923366765129;954.231843366097;970.1801977329145;9222.953885230665;10122.544485498023;10213.948930255301;10247;10416.270861039806;557276;558324;561569;566023;619468.9026554838;126998;132920.67079329275;136646;136878;141319.29340353233;1007.808516381885;1025.646152077532;1049.79004199162;1055.2191378379944;1055.3773273768513;13576.93211533936;17686.557836054202;17690.734638980168;18039.458816235532;18191.363302284357;47178.528214717415;50597.74701126618;52927.20609190942;52948.94102118013;53197.734011329696;76037.61981190059;76240.23759762332;77603.44793104219;80004.79992799996;83510;6364.427201551883;7721.343685786546;7761.495502792301;7878.448508604342;7951.204879512003;10971.50628221716;12158.297838302467;12288.508459661514;12568.434420450918;12569.497220111092;10616.575336986434;10739.087177589992;10800;10909.618163364245;11006.614768483065;10417.47912604382;10472.790544189225;10547.736306592089;10756.677299681021;10824.4046577439;7614.619269036637;10372.222083343628;10511.789764204826;11087.44562771842;11159.051480624237;7762.883556746766;7763;7996.20037996219;7998.680052797823;8074;9073.13805188506;10200;10259;10316.587336506456;10316.793664126826 11:49:59 INFO - PROCESS | 1661 | |3;mootools.html;1425.15203453945;1624.236608793867;1631.8368163183684;1901.3630433804674;2025.6151331247072;7951.085625153102;8666.306695464356;8849.513276769776;8883.55582220888;8909.821803563933;8479.194476524735;8726.301895848334;8737.95631021844;8740.519271440084;8742.825143497143;2144.9785502145014;2218.5784700906856;2388.8447250928634;2439.377958620549;2474.8886300116537;2441.548313561988;2463.3964678653756;2463.6181391884197;2464.0759715106833;2475.5296493666237;2421.806255499556;2453.0555736041665;2475.4059025833762;2476.071473197551;2485.291691867818;2073.668213085914;2345.636426353918;2417.093589903786;2433.85396876188;2435.305937807725;2433.671454353675;2444.69441319835;2452.1662634704107;2456.7911727503183;2461.6307553866886;8697.826043479095;8705.173008564176;8740.169683880022;8770.649174033031;8790.956045219797;5203.713795741271;5372.865678358034;5380.784768609251;5385.838424847261;5401.459854014606;3380.138064793462;3398.8300584970652;3616.1321282891918;3623.058004918714;3627.7279204059537;995.4624502768569;999.5901680311038;999.975000624983;1010.8231059564547;1016.4206402350663;11697.590584329593;11736.178467507278;11757.647270581896;11762.294262344201;11763.294202347886;4745.1695953208055;4780.122302942599;4796.472388037313;4923.77842997066;4935;10011.599536018623;10092.848607270897;10097.848532272023;10099.848502272473;10108.797824043479;5438.864028399322;5439.864003399946;5449.536789372868;5457.345118585716;5484.588655850827;4285.335772955197;4424.646028317791;4579.22153233951;4600.861974140781;4976.178930476503;3746.6066063062985;4131.5455299916985;4133.111381053028;4142.881422016099;4167.958320416757;1166.4692564882957;1319.188698950158;1360.5646193218074;1363.2093385836192;1373.9313034348243;910.8269428808505;934.6588495199203;937.4515908193783;955.1690029674089;989.5942663507927;5029.7736601853;5978.970105149447;5995.460408563163;6112.266528016667;6142.017277235621;438.4300409467679;438.73018093872037;451.56649616368;457.16795432313535;457.4145094279328;3575.249197668467;3623.2934577757082;3999.6000399960353;4021.4571032910767;4093.8771836844944;10339.9483002586;10585.259031867696;10792.028717415471;10798.190135739695;10943.83584246237;10746.892531074745;10819.729506762395;10823.729406764895;10832.079273261861;10951.178661600412;6570.244421891448;8073.394495412867;8201.384896132813;8344.415890887702;8589.840371549886;5222.634415590872;5847.152162936265;5958.374370691015;6009.579329446897;6105.3873105076445;9902.158316542886;9954.900450995687;10038.498075096362;10048.397096174253;10055.19558435338;9726.416415015121;9939.900600993897;10126.797464050826;10128.189744820249;10286.742831429274;6813.931860681329;7081.964590177016;7497.475176737794;7594.696212151673;7594.936708860653;8094.311983481234;8383.41316107891;8390.916090839257;8393.496390216607;8394.45436046655;7172.641367931687;7332.30343117403;7346.191918889025;7473.364763995121;7501.62491875415;7113.75101871432;7256.7822965311125;7338.816529586589;7388.741394051182;7425.591592462466;7011.193712723102;7112.217656057933;7114.217436081924;7120.430365570845;7124.715011399486;4814.831480898151;4889.706617602955;4928.088303663833;5061.519155680205;5121.206213036985;4820.25286080658;4974.179260422135;4997.5002499749735;5157.07172708916;5298.28473156119 11:49:59 INFO - PROCESS | 1661 | |4;prototype.html;310.4412058295068;316.1022695544653;326.5053444032292;328.93256882339125;330.37723890466464;4385.539518350575;5876.147958546014;5940.257467816523;5941.732622032008;6005.4895333896675;4763.404574428197;5890.587658863881;5898.115282707596;5907.430267833495;5969.671668058255;4332.090261045184;4498.280275155976;4500.347449619803;4519.118771839484;4523.5024147343765;4158.688098392618;4421.646268298545;4422.18189634917;4513.593776560109;4518.3222516622445;3966.841326346943;4312.417823593822;4339.088791353819;4371.65026797857;4374.759388233646;3624;4377.4528183977;4380.737155770648;4392.868213953587;4400;3530.382183117944;3787.9393769744515;3793.336166170909;3793.3551296279697;3807.485989391452;5631.64840438296;5674.943250567483;5680.829575112753;5688;5705.62913410627;4780.306855505967;5035.482258870565;5036.370453693288;5058;5079;5792.073268277098;5811.012127938261;5969.313528944183;6203.16257305267;6237.500999919996;4102.794860257005;4105.507339119325;4118.464599602063;4134.710570260083;4135.8966025849595;6228.252609686821;6260.780872669435;6433.517486188554;6503.577267477599;6600.834979125512;3423;3866.7873266970023;3985.720999530005;4067.084905896209;4187.853425130106;3294.9950265168873;4231.724937879028;4242.44848169736;4274.145170965757;4294.0767734937135;4444.533324000998;5003.999200159982;5024.472430394829;5024.598032157419;5054.368203974504;5032.0690672225755;5188.507091826271;6023.397660233942;6306.3378345274;6322.810315690536;1279.5777393460137;1303.2310936547483;1413.321605629283;1450.6735984403635;1478.2830327291256;928.4568527411404;957.8850537935492;960.1838437328215;970.6505657963128;975.9219262458986;4783.019481006455;5774.220480235114;5819.679917604488;5820.621659592113;5846.269216347957;6463.15978922737;6477.449416799531;6482.351764823574;6493.415592596689;6535.836604084936;5574.386817450078;5772.595918285764;5794.159846822272;5805.651660900275;5805.7387417566315;2832.8158669686404;3388;3391.4743214801747;3420.196253880336;3421.555197824267;5264.368275806928;5810.389909059572;6001.609895356788;6718.596884186964;6789.6605169741315;6288.119663247149;6734.393904548516;6740.090087838079;6758.336747644208;6764.255931847493;6524.412802847766;6819.931800682029;6852.965735171392;6864.24493305736;6875.278095799869;5178.249153872743;5335.226392173191;6146.477549408351;6393.968030159819;6545.14913061299;5596.916046259228;6090.670663169726;6458.61248325102;6463.385978332051;6471.514636402195;6250.218722659668;6401.455876250571;6790.898136528055;6827.761028363983;6853.246142924374;3517.771344862576;3601.585817631006;3762.1347090168865;4214.726042807208;4230.0905305358265;6255.624662520263;6560.343965603402;6575.112359831362;6575.704093315717;6579.276279609335;5202.115640341227;6298.748050077946;6342.746290148342;6360.713767880364;6429.421352078149;5589.413111623384;5925.903707814068;6331.683415829098;6339.2392912850755;6349.174607301022;5132.666376685504;5425.636105614386;5929.080992446177;6178.876422471435;6215.9378406215355;5226.66026708278;6245.7189426476825;6282.246130464374;6331.366863313632;6339.873202536016;5422.430644782399;5933.436323549256;6189.938100618936;6197.1324014638885;6212.720427580679 11:49:59 INFO - PROCESS | 1661 | |5;yui.html;626.3329554024963;646.712213065186;682.7985744205456;730.2077246187886;736.924090827392;14790.704185916275;15210.087394756323;15238.542843714678;15245.93278470506;15254.847451525482;12795.744085118293;13674.111182773138;13847.792283115736;13918.930405347985;13923.860761392383;917.2799352508266;924.7040946896996;935.7988032572996;936.4381371177308;936.66748304352;923.1184219070805;928.2620316848122;929.4794914847673;929.6188562689299;931.455098767222;982.3958265666635;985.9852102218473;986.7039888033597;988.3970777825521;989.0208693393561;979.7697541077841;980.0983095552109;981.219930155521;982.9017098290185;983.4984158079395;731.1299553531334;731.3052600029993;731.5281643340016;732.2165283147035;733.3216774483582;13104.475820967149;13142;13164;13173.34133293341;13207.801882971764;11143.944280278627;11242.943785281102;11303.208775385727;11516.251443656136;11671.474783634672;9091.454512729257;9244.352895297332;9300.20948219402;9325.906740932573;9386.014468480847;3377.257003459235;3407.71034462071;3426.811525366104;3487.8604855805993;3611.1523795374583;63713.68143159301;71639.28360716379;72704.6364768178;79057;79147;9545.331826772059;9669.758256043655;9856.50717464124;9965.302428830057;10575.41835199056;21786.673199902016;22075.66886496704;22129.557408852055;22131.668024979637;22149.446263843533;7505.924940750632;7630.694772209161;7644.273793989562;7779.416543759241;7940.642671079815;4057.736247143926;4125.64931980779;4133.648639865585;4178.540360560397;4428.269335559597;3458.8616455341503;3515.54297941266;3525.4888041233876;3527.894163175109;3530.7881527108457;637.388107416885;644.2848438233557;646.8641585267146;650.9349065093453;666.9966650166815;532.7442827442771;556.210181542211;573.1116769008021;576.331455511613;592.2626330218905;7739.845203095907;7813.882791758128;7869.134395216522;7880.921190788134;7908.644111015018;553.8766410701015;581.9301683797971;588.4115884115885;600.0429315242181;612.9601575897552;3661.835217415223;3758.4362345648374;3768.510093687803;3774.54705435344;3781.4516895050065;81878.59060704659;83270;84031;84096.57951710203;89730.55134724284;66430.00354994582;73208.63395682987;74079.62960185164;74523;75577.62211188908;54105.45894541083;56462.58843528945;71153.64423177851;71290.57418851594;71500;8169.918300816916;8189.462162296774;8225;8295.668173273243;8404.033536143423;44253.336199956386;44296.33555496734;44620.77689611531;45905.54094459146;45993.31010034919;54681.72659136679;65030;65276.34723652703;65537;65622;10712.982266684965;10714.303570267908;10771.676849694522;10950.45247737594;10966.451677416257;11790.056795456514;11830.40847957616;11859.703507412383;11963.342016189194;12800.74398512043;9845.45849978258;10384.636537721144;10406;10958.178136639624;10968.835467468154;9963.352382095141;10168.186545076524;10170.288079834636;10268.281220314506;10491.842622360518;7965.800854978672;9542.141207291377;9762.121409072934;10016.64941727036;10320.329178603366;8656.307495400228;8662.82674346497;8963.05887881763;9054.230390416626;9385.571979593158;7572.545647261182;8036.879446808186;8169.183081692021;8358.95820520918;8996.505192214228 11:49:59 INFO - PROCESS | 1661 | __end_tp_report 11:49:59 INFO - PROCESS | 1661 | __start_cc_report 11:49:59 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1188 11:49:59 INFO - PROCESS | 1661 | __end_cc_report 11:49:59 INFO - PROCESS | 1661 | __startTimestamp1461350999473__endTimestamp 11:49:59 INFO - PROCESS | 1661 | 11:49:59 INFO - PROCESS | 1661 | ------- Summary: start ------- 11:49:59 INFO - PROCESS | 1661 | Number of tests: 6 11:49:59 INFO - PROCESS | 1661 | 11:49:59 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5718.81 Median:5906.65 stddev:640.76 (10.8%) stddev-sans-first:608.22 11:49:59 INFO - PROCESS | 1661 | Values: 3074.6 3458.4 3479.5 3492.3 3511.9 5622.3 5665.7 5695.8 5710.5 5719.3 5678.8 5728.7 5754.8 5815.7 5900.0 5160.5 5172.2 5209.0 5219.4 5328.2 5277.5 5291.3 5313.5 5319.3 5369.3 5148.7 5256.7 5259.4 5265.7 5273.8 5238.9 5258.7 5262.6 5269.3 5276.6 5176.9 5190.7 5232.0 5232.9 5245.7 5587.6 5610.3 5617.0 5663.6 5680.9 6123.9 6143.3 6219.2 6243.9 6275.5 6205.6 6287.4 6310.6 6313.9 6319.7 4899.8 5184.5 5610.4 5740.6 5809.8 6207.9 6230.9 6268.1 6276.4 6300.1 6164.4 6176.0 6189.6 6199.3 6201.3 6135.8 6237.1 6280.6 6286.2 6291.2 6121.4 6216.7 6232.0 6237.1 6244.5 6239.3 6249.6 6252.0 6252.4 6277.1 4802.3 4854.2 4896.7 4920.6 4957.0 4376.6 4408.7 4433.7 4444.3 4444.7 5533.1 5574.3 5576.7 5594.3 5599.1 6142.8 6145.3 6146.8 6160.1 6163.4 5624.3 5678.8 5705.1 5731.9 5740.2 5370.2 5391.9 5398.0 5400.2 5418.6 5220.2 6201.5 6261.2 6351.5 6358.6 6257.5 6309.0 6313.8 6315.7 6318.1 6322.2 6333.1 6349.1 6364.3 6380.5 5139.8 6075.2 6118.8 6124.6 6153.4 6257.5 6274.6 6281.9 6295.2 6319.2 5197.9 6053.3 6133.5 6139.7 6161.6 5956.4 6015.3 6107.5 6109.8 6125.4 5302.5 5677.9 5947.7 5951.4 5975.1 6071.3 6134.0 6143.8 6148.1 6150.7 5748.9 5903.0 5906.6 6015.4 6024.6 11:49:59 INFO - PROCESS | 1661 | 11:49:59 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:64014.87 Median:36564.36 stddev:139784.53 (382.3%) stddev-sans-first:140095.39 11:49:59 INFO - PROCESS | 1661 | Values: 525.2 537.5 555.2 575.0 604.2 31105.0 38392.8 39641.2 39728.2 39878.4 42363.0 43079.4 43112.1 43172.7 43271.9 8612.5 9425.9 9696.3 9706.0 9710.7 8698.3 8821.1 8822.3 8843.0 11642.1 11581.2 11670.1 11675.8 11691.8 11696.2 11515.2 11592.7 11593.3 11610.1 11614.7 8668.5 8936.7 8940.6 8945.0 11518.3 40516.4 41437.0 41462.8 41582.6 41720.0 3207.4 3311.3 3464.0 3559.9 3973.9 27377.3 27569.6 27597.2 27633.4 27855.4 2674.4 2690.3 2698.3 2713.7 2810.1 441295.0 442867.0 444694.8 444934.0 445895.0 36484.1 37511.0 62474.0 62926.0 63006.0 36394.5 36471.0 36675.1 36694.6 36791.6 15206.1 15396.0 15402.5 15412.5 15437.5 12931.5 13005.9 13006.9 13019.8 13020.0 7725.2 7852.8 8132.8 8212.1 8296.4 2747.6 3166.9 3343.5 3351.4 3379.6 902.4 1001.8 1061.7 1066.7 1113.9 29870.3 29883.3 30514.5 30719.4 30922.0 1066.9 1094.6 1102.9 1104.3 1170.0 14558.9 15568.5 15580.0 15884.1 15907.0 644282.0 650531.0 657579.0 658457.0 671100.0 60974.0 62013.0 62061.0 62125.7 62408.1 1332.6 1494.4 1501.8 1511.7 1554.8 27087.5 28727.9 29261.4 29294.7 29348.4 49616.0 50139.0 50248.0 50260.7 50433.0 430896.0 436036.8 438862.0 439796.0 439846.0 22751.0 27296.5 27781.9 27798.0 27867.3 44313.8 45469.0 45817.9 46231.0 47701.0 37630.8 37684.1 37880.4 38191.2 38405.6 33034.7 34126.0 37430.6 37636.1 38129.4 36644.6 36726.0 36904.0 37401.0 37740.6 32311.5 32438.0 32875.2 32978.5 33410.0 21136.0 23320.6 24404.6 24671.3 24880.0 11:49:59 INFO - PROCESS | 1661 | 11:49:59 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:34289.15 Median:11760.43 stddev:96142.25 (817.5%) stddev-sans-first:96378.27 11:49:59 INFO - PROCESS | 1661 | Values: 392.9 394.8 399.3 402.2 410.4 13866.0 20002.0 20656.5 20766.9 20776.6 15908.3 17277.0 19770.8 20240.8 20689.6 5813.7 5999.0 6020.9 6033.2 6033.8 5684.9 5895.7 5906.4 5942.5 5992.0 5003.4 5859.3 5864.1 5875.6 5899.3 5704.1 5816.7 5917.9 5925.6 5930.6 5204.8 5219.3 5220.8 5221.1 5224.9 23650.2 24708.4 25841.5 25897.9 25922.4 1780.3 2120.5 2227.9 2231.1 2420.7 12045.2 14655.6 14766.7 14890.3 15243.3 1638.3 1672.4 1706.3 1738.4 1760.2 114559.0 118496.0 119066.0 119207.0 121919.0 10400.3 10822.3 10860.3 10869.6 11096.2 13600.1 13696.2 13723.9 13732.1 13741.9 6865.9 7082.4 7219.6 8021.6 8540.6 8392.3 8586.8 8617.5 8735.7 8763.4 5327.7 6357.2 6479.2 6487.9 6565.8 1600.9 1849.6 1883.3 1887.2 1889.9 889.4 925.6 957.3 1039.9 1040.1 16073.6 20582.5 20713.0 20768.2 21293.0 868.3 915.3 931.5 954.2 970.2 9223.0 10122.5 10213.9 10247.0 10416.3 557276.0 558324.0 561569.0 566023.0 619468.9 126998.0 132920.7 136646.0 136878.0 141319.3 1007.8 1025.6 1049.8 1055.2 1055.4 13576.9 17686.6 17690.7 18039.5 18191.4 47178.5 50597.7 52927.2 52948.9 53197.7 76037.6 76240.2 77603.4 80004.8 83510.0 6364.4 7721.3 7761.5 7878.4 7951.2 10971.5 12158.3 12288.5 12568.4 12569.5 10616.6 10739.1 10800.0 10909.6 11006.6 10417.5 10472.8 10547.7 10756.7 10824.4 7614.6 10372.2 10511.8 11087.4 11159.1 7762.9 7763.0 7996.2 7998.7 8074.0 9073.1 10200.0 10259.0 10316.6 10316.8 11:49:59 INFO - PROCESS | 1661 | 11:49:59 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5713.58 Median:4817.54 stddev:3214.69 (66.7%) stddev-sans-first:3207.55 11:49:59 INFO - PROCESS | 1661 | Values: 1425.2 1624.2 1631.8 1901.4 2025.6 7951.1 8666.3 8849.5 8883.6 8909.8 8479.2 8726.3 8738.0 8740.5 8742.8 2145.0 2218.6 2388.8 2439.4 2474.9 2441.5 2463.4 2463.6 2464.1 2475.5 2421.8 2453.1 2475.4 2476.1 2485.3 2073.7 2345.6 2417.1 2433.9 2435.3 2433.7 2444.7 2452.2 2456.8 2461.6 8697.8 8705.2 8740.2 8770.6 8791.0 5203.7 5372.9 5380.8 5385.8 5401.5 3380.1 3398.8 3616.1 3623.1 3627.7 995.5 999.6 1000.0 1010.8 1016.4 11697.6 11736.2 11757.6 11762.3 11763.3 4745.2 4780.1 4796.5 4923.8 4935.0 10011.6 10092.8 10097.8 10099.8 10108.8 5438.9 5439.9 5449.5 5457.3 5484.6 4285.3 4424.6 4579.2 4600.9 4976.2 3746.6 4131.5 4133.1 4142.9 4168.0 1166.5 1319.2 1360.6 1363.2 1373.9 910.8 934.7 937.5 955.2 989.6 5029.8 5979.0 5995.5 6112.3 6142.0 438.4 438.7 451.6 457.2 457.4 3575.2 3623.3 3999.6 4021.5 4093.9 10339.9 10585.3 10792.0 10798.2 10943.8 10746.9 10819.7 10823.7 10832.1 10951.2 6570.2 8073.4 8201.4 8344.4 8589.8 5222.6 5847.2 5958.4 6009.6 6105.4 9902.2 9954.9 10038.5 10048.4 10055.2 9726.4 9939.9 10126.8 10128.2 10286.7 6813.9 7082.0 7497.5 7594.7 7594.9 8094.3 8383.4 8390.9 8393.5 8394.5 7172.6 7332.3 7346.2 7473.4 7501.6 7113.8 7256.8 7338.8 7388.7 7425.6 7011.2 7112.2 7114.2 7120.4 7124.7 4814.8 4889.7 4928.1 5061.5 5121.2 4820.3 4974.2 4997.5 5157.1 5298.3 11:49:59 INFO - PROCESS | 1661 | 11:49:59 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:5024.93 Median:5739.11 stddev:1609.83 (28.1%) stddev-sans-first:1574.98 11:49:59 INFO - PROCESS | 1661 | Values: 310.4 316.1 326.5 328.9 330.4 4385.5 5876.1 5940.3 5941.7 6005.5 4763.4 5890.6 5898.1 5907.4 5969.7 4332.1 4498.3 4500.3 4519.1 4523.5 4158.7 4421.6 4422.2 4513.6 4518.3 3966.8 4312.4 4339.1 4371.7 4374.8 3624.0 4377.5 4380.7 4392.9 4400.0 3530.4 3787.9 3793.3 3793.4 3807.5 5631.6 5674.9 5680.8 5688.0 5705.6 4780.3 5035.5 5036.4 5058.0 5079.0 5792.1 5811.0 5969.3 6203.2 6237.5 4102.8 4105.5 4118.5 4134.7 4135.9 6228.3 6260.8 6433.5 6503.6 6600.8 3423.0 3866.8 3985.7 4067.1 4187.9 3295.0 4231.7 4242.4 4274.1 4294.1 4444.5 5004.0 5024.5 5024.6 5054.4 5032.1 5188.5 6023.4 6306.3 6322.8 1279.6 1303.2 1413.3 1450.7 1478.3 928.5 957.9 960.2 970.7 975.9 4783.0 5774.2 5819.7 5820.6 5846.3 6463.2 6477.4 6482.4 6493.4 6535.8 5574.4 5772.6 5794.2 5805.7 5805.7 2832.8 3388.0 3391.5 3420.2 3421.6 5264.4 5810.4 6001.6 6718.6 6789.7 6288.1 6734.4 6740.1 6758.3 6764.3 6524.4 6819.9 6853.0 6864.2 6875.3 5178.2 5335.2 6146.5 6394.0 6545.1 5596.9 6090.7 6458.6 6463.4 6471.5 6250.2 6401.5 6790.9 6827.8 6853.2 3517.8 3601.6 3762.1 4214.7 4230.1 6255.6 6560.3 6575.1 6575.7 6579.3 5202.1 6298.7 6342.7 6360.7 6429.4 5589.4 5925.9 6331.7 6339.2 6349.2 5132.7 5425.6 5929.1 6178.9 6215.9 5226.7 6245.7 6282.2 6331.4 6339.9 5422.4 5933.4 6189.9 6197.1 6212.7 11:49:59 INFO - PROCESS | 1661 | 11:49:59 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:17065.74 Median:32840.47 stddev:23670.06 (72.1%) stddev-sans-first:23704.27 11:49:59 INFO - PROCESS | 1661 | Values: 626.3 646.7 682.8 730.2 736.9 14790.7 15210.1 15238.5 15245.9 15254.8 12795.7 13674.1 13847.8 13918.9 13923.9 917.3 924.7 935.8 936.4 936.7 923.1 928.3 929.5 929.6 931.5 982.4 986.0 986.7 988.4 989.0 979.8 980.1 981.2 982.9 983.5 731.1 731.3 731.5 732.2 733.3 13104.5 13142.0 13164.0 13173.3 13207.8 11143.9 11242.9 11303.2 11516.3 11671.5 9091.5 9244.4 9300.2 9325.9 9386.0 3377.3 3407.7 3426.8 3487.9 3611.2 63713.7 71639.3 72704.6 79057.0 79147.0 9545.3 9669.8 9856.5 9965.3 10575.4 21786.7 22075.7 22129.6 22131.7 22149.4 7505.9 7630.7 7644.3 7779.4 7940.6 4057.7 4125.6 4133.6 4178.5 4428.3 3458.9 3515.5 3525.5 3527.9 3530.8 637.4 644.3 646.9 650.9 667.0 532.7 556.2 573.1 576.3 592.3 7739.8 7813.9 7869.1 7880.9 7908.6 553.9 581.9 588.4 600.0 613.0 3661.8 3758.4 3768.5 3774.5 3781.5 81878.6 83270.0 84031.0 84096.6 89730.6 66430.0 73208.6 74079.6 74523.0 75577.6 54105.5 56462.6 71153.6 71290.6 71500.0 8169.9 8189.5 8225.0 8295.7 8404.0 44253.3 44296.3 44620.8 45905.5 45993.3 54681.7 65030.0 65276.3 65537.0 65622.0 10713.0 10714.3 10771.7 10950.5 10966.5 11790.1 11830.4 11859.7 11963.3 12800.7 9845.5 10384.6 10406.0 10958.2 10968.8 9963.4 10168.2 10170.3 10268.3 10491.8 7965.8 9542.1 9762.1 10016.6 10320.3 8656.3 8662.8 8963.1 9054.2 9385.6 7572.5 8036.9 8169.2 8359.0 8996.5 11:49:59 INFO - PROCESS | 1661 | -------- Summary: end -------- 11:49:59 INFO - PROCESS | 1661 | 11:50:00 INFO - TEST-INFO | 1661: exit 0 11:50:00 INFO - TEST-OK | dromaeo_css | took 1114759ms 11:50:00 INFO - TEST-START | kraken 11:50:00 INFO - operating with platform_type : mac_ 11:50:00 INFO - Initialising browser for kraken test... 11:50:00 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmp9kWpzR/profile http://localhost:49275/getInfo.html) 11:50:02 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 11:50:02 INFO - PROCESS | 1670 | colorDepth:24 11:50:02 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 11:50:02 INFO - PROCESS | 1670 | __metrics 11:50:02 INFO - PROCESS | 1670 | 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" 11:50:02 ERROR - PROCESS | 1670 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:50:02 INFO - TEST-INFO | 1670: exit 0 11:50:02 INFO - Browser initialized. 11:50:02 INFO - Running cycle 1/1 for kraken test... 11:50:02 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmp9kWpzR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:14 INFO - PROCESS | 1672 | RSS: Main: 238989312 11:50:14 INFO - PROCESS | 1672 | 11:50:17 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 11:50:18 INFO - PROCESS | 1672 | RSS: Main: 286330880 11:50:18 INFO - PROCESS | 1672 | 11:50:20 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 11:50:21 INFO - PROCESS | 1672 | RSS: Main: 299913216 11:50:21 INFO - PROCESS | 1672 | 11:50:24 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 11:50:25 INFO - PROCESS | 1672 | RSS: Main: 391254016 11:50:25 INFO - PROCESS | 1672 | 11:50:27 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 11:50:28 INFO - PROCESS | 1672 | RSS: Main: 289079296 11:50:28 INFO - PROCESS | 1672 | 11:50:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:50:31 INFO - PROCESS | 1672 | RSS: Main: 294019072 11:50:31 INFO - PROCESS | 1672 | 11:50:33 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 11:50:34 INFO - PROCESS | 1672 | RSS: Main: 333971456 11:50:34 INFO - PROCESS | 1672 | 11:50:37 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 11:50:37 INFO - PROCESS | 1672 | RSS: Main: 333623296 11:50:37 INFO - PROCESS | 1672 | 11:50:40 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 11:50:41 INFO - PROCESS | 1672 | RSS: Main: 330973184 11:50:41 INFO - PROCESS | 1672 | 11:50:42 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:50:43 INFO - PROCESS | 1672 | RSS: Main: 321458176 11:50:43 INFO - PROCESS | 1672 | 11:50:45 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:50:45 INFO - PROCESS | 1672 | RSS: Main: 328765440 11:50:45 INFO - PROCESS | 1672 | 11:50:48 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:50:48 INFO - PROCESS | 1672 | RSS: Main: 330153984 11:50:48 INFO - PROCESS | 1672 | 11:50:51 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:50:52 INFO - PROCESS | 1672 | RSS: Main: 334921728 11:50:52 INFO - PROCESS | 1672 | 11:50:55 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:50:55 INFO - PROCESS | 1672 | RSS: Main: 332640256 11:50:55 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 11:50:57 INFO - PROCESS | 1672 | RSS: Main: 397049856 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | __start_tp_report 11:50:57 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 11:50:57 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 11:50:57 INFO - PROCESS | 1672 | |i|pagename|runs| 11:50:57 INFO - PROCESS | 1672 | |0;ai-astar;112;109;112;113;110;111;118;111;112;112 11:50:57 INFO - PROCESS | 1672 | |1;audio-beat-detection;158;121;144;172;121;141;144;122;171;119 11:50:57 INFO - PROCESS | 1672 | |2;audio-dft;184;186;184;186;185;179;183;180;184;183 11:50:57 INFO - PROCESS | 1672 | |3;audio-fft;77;73;90;93;55;59;58;79;84;45 11:50:57 INFO - PROCESS | 1672 | |4;audio-oscillator;95;129;175;112;86;83;116;76;79;115 11:50:57 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;88;85;87;89;131;117;87;84;86;86 11:50:57 INFO - PROCESS | 1672 | |6;imaging-darkroom;93;96;94;93;92;93;92;101;94;93 11:50:57 INFO - PROCESS | 1672 | |7;imaging-desaturate;84;84;84;86;85;84;85;85;86;83 11:50:57 INFO - PROCESS | 1672 | |8;json-parse-financial;59;61;61;58;60;59;61;81;60;59 11:50:57 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;66;63;74;77;77;72;69;67;66;69 11:50:57 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;81;82;80;82;83;80;80;81;82;83 11:50:57 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;139;137;137;137;145;150;150;157;187;142 11:50:57 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;181;170;224;221;173;170;170;168;167;174 11:50:57 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;68;69;69;68;71;67;69;70;67;67 11:50:57 INFO - PROCESS | 1672 | __end_tp_report 11:50:57 INFO - PROCESS | 1672 | __start_cc_report 11:50:57 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1992 11:50:57 INFO - PROCESS | 1672 | __end_cc_report 11:50:57 INFO - PROCESS | 1672 | __startTimestamp1461351057826__endTimestamp 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | ------- Summary: start ------- 11:50:57 INFO - PROCESS | 1672 | Number of tests: 14 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:2.40 (2.1%) stddev-sans-first:2.55 11:50:57 INFO - PROCESS | 1672 | Values: 112.0 109.0 112.0 113.0 110.0 111.0 118.0 111.0 112.0 112.0 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:144.00 stddev:20.58 (14.3%) stddev-sans-first:20.92 11:50:57 INFO - PROCESS | 1672 | Values: 158.0 121.0 144.0 172.0 121.0 141.0 144.0 122.0 171.0 119.0 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:2.32 (1.3%) stddev-sans-first:2.45 11:50:57 INFO - PROCESS | 1672 | Values: 184.0 186.0 184.0 186.0 185.0 179.0 183.0 180.0 184.0 183.0 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:71.30 Median:78.00 stddev:16.20 (20.8%) stddev-sans-first:17.05 11:50:57 INFO - PROCESS | 1672 | Values: 77.0 73.0 90.0 93.0 55.0 59.0 58.0 79.0 84.0 45.0 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:106.60 Median:77.50 stddev:30.15 (38.9%) stddev-sans-first:31.69 11:50:57 INFO - PROCESS | 1672 | Values: 95.0 129.0 175.0 112.0 86.0 83.0 116.0 76.0 79.0 115.0 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:94.00 Median:86.50 stddev:16.21 (18.7%) stddev-sans-first:17.05 11:50:57 INFO - PROCESS | 1672 | Values: 88.0 85.0 87.0 89.0 131.0 117.0 87.0 84.0 86.0 86.0 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:93.00 stddev:2.69 (2.9%) stddev-sans-first:2.82 11:50:57 INFO - PROCESS | 1672 | Values: 93.0 96.0 94.0 93.0 92.0 93.0 92.0 101.0 94.0 93.0 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.97 (1.1%) stddev-sans-first:1.00 11:50:57 INFO - PROCESS | 1672 | Values: 84.0 84.0 84.0 86.0 85.0 84.0 85.0 85.0 86.0 83.0 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:60.50 stddev:6.79 (11.2%) stddev-sans-first:7.12 11:50:57 INFO - PROCESS | 1672 | Values: 59.0 61.0 61.0 58.0 60.0 59.0 61.0 81.0 60.0 59.0 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.50 stddev:4.83 (6.9%) stddev-sans-first:4.90 11:50:57 INFO - PROCESS | 1672 | Values: 66.0 63.0 74.0 77.0 77.0 72.0 69.0 67.0 66.0 69.0 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:82.00 stddev:1.17 (1.4%) stddev-sans-first:1.24 11:50:57 INFO - PROCESS | 1672 | Values: 81.0 82.0 80.0 82.0 83.0 80.0 80.0 81.0 82.0 83.0 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:147.50 stddev:15.27 (10.4%) stddev-sans-first:15.84 11:50:57 INFO - PROCESS | 1672 | Values: 139.0 137.0 137.0 137.0 145.0 150.0 150.0 157.0 187.0 142.0 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.80 Median:173.50 stddev:21.82 (12.6%) stddev-sans-first:23.14 11:50:57 INFO - PROCESS | 1672 | Values: 181.0 170.0 224.0 221.0 173.0 170.0 170.0 168.0 167.0 174.0 11:50:57 INFO - PROCESS | 1672 | 11:50:57 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 11:50:57 INFO - PROCESS | 1672 | Values: 68.0 69.0 69.0 68.0 71.0 67.0 69.0 70.0 67.0 67.0 11:50:57 INFO - PROCESS | 1672 | -------- Summary: end -------- 11:50:57 INFO - PROCESS | 1672 | 11:50:58 INFO - TEST-INFO | 1672: exit 0 11:50:58 INFO - TEST-OK | kraken | took 58541ms 11:50:58 INFO - SUITE-END | took 1173s 11:50:58 INFO - Completed test suite (00:19:33) 11:50:58 INFO - javascript benchmark 11:50:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.6156730408698, 3458.3602033623783, 3479.5476588043553, 3492.3189977954275, 3511.947320790187, 5622.269105016352, 5665.688387138705, 5695.772169113241, 5710.457506536877, 5719.256496655435, 5678.801241956532, 5728.68492232927, 5754.769809207637, 5815.709214539277, 5899.970500147504, 5160.509751573594, 5172.172452407597, 5209.0, 5219.399769026572, 5328.20076988451, 5277.498637629438, 5291.312129423189, 5313.548348390392, 5319.281896943921, 5369.275147855048, 5148.74256287186, 5256.658317209369, 5259.421463638997, 5265.710385928773, 5273.789048438058, 5238.8690282742855, 5258.737063146866, 5262.60530460217, 5269.314989051437, 5276.604254680914, 5176.896462070775, 5190.688558686453, 5231.973840130813, 5232.895342093137, 5245.737713114329, 5587.55299576037, 5610.270664813548, 5617.0, 5663.575231857627, 5680.8863822723315, 6123.862238009563, 6143.2662465203, 6219.222597175353, 6243.906341404882, 6275.497960163221, 6205.627662340229, 6287.402696743802, 6310.6213627182515, 6313.905291420632, 6319.747210111636, 4899.828506002308, 5184.496496016151, 5610.438956104438, 5740.569457290637, 5809.7966571170655, 6207.937920620826, 6230.937690623126, 6268.09112678659, 6276.403741644536, 6300.054991751183, 6164.383561643889, 6175.96912015446, 6189.6286222826775, 6199.256089269316, 6201.286852012076, 6135.814547850636, 6237.064440333987, 6280.591761535486, 6286.245650521967, 6291.150694656254, 6121.392004143319, 6216.720247588779, 6232.0, 6237.09562113491, 6244.500439964792, 6239.313675495692, 6249.625022498664, 6252.0, 6252.406021427957, 6277.121203031579, 4802.303665968415, 4854.150523658345, 4896.6572339935865, 4920.5571498565305, 4957.033378491232, 4376.606105450461, 4408.669349798778, 4433.667474939392, 4444.31113177458, 4444.7110937789585, 5533.114701647717, 5574.275344205308, 5576.665400076008, 5594.272744543265, 5599.1041433370465, 6142.8057410146475, 6145.324014358417, 6146.7706458708435, 6160.075988601746, 6163.38366163389, 5624.268845050117, 5678.829635110953, 5705.087186050295, 5731.914021289684, 5740.225069615549, 5370.248165256867, 5391.919121213185, 5397.973010135002, 5400.243965844785, 5418.620696551204, 5220.243064755589, 6201.472874805692, 6261.154744109669, 6351.491880649537, 6358.618482891041, 6257.4681152102585, 6308.968455157878, 6313.842153946188, 6315.652639104709, 6318.115463835159, 6322.209723784527, 6333.050042493663, 6349.111124442674, 6364.299927008118, 6380.489560835029, 5139.768710407966, 6075.210222671025, 6118.832384214075, 6124.5712800103565, 6153.4154255345675, 6257.468115210076, 6274.560780745304, 6281.937180628135, 6295.244570651551, 6319.24169099711, 5197.948020519746, 6053.303870055, 6133.478654314434, 6139.693015349304, 6161.568690191643, 5956.434138756811, 6015.2781666200335, 6107.511399087974, 6109.816705498843, 6125.356837531995, 5302.496262855023, 5677.8864422710485, 5947.702614869153, 5951.404859514014, 5975.133605627247, 6071.301800293023, 6134.0, 6143.801958618026, 6148.077788331607, 6150.661713605795, 5748.856278592902, 5902.970485147547, 5906.645601263938, 6015.428534289235, 6024.608400453956], "value": 5679.016488382589, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.1990714160902, 537.5296615461472, 555.2476394485469, 574.9564540359248, 604.2235727090689, 31105.0, 38392.80803595982, 39641.20717585643, 39728.205435891265, 39878.401823972665, 42363.0, 43079.3538096928, 43112.13775724483, 43172.70481885548, 43271.889170528746, 8612.48325100493, 9425.905740942588, 9696.272779541527, 9705.951470242639, 9710.660126895526, 8698.260647844909, 8821.117888211193, 8822.338324625647, 8842.955785221066, 11642.068634509262, 11581.247218930785, 11670.066394688447, 11675.766484670345, 11691.766164676701, 11696.239744416585, 11515.193936424412, 11592.6522204334, 11593.304401735923, 11610.071194304477, 11614.651560453116, 8668.52323122228, 8936.687215947411, 8940.64237430502, 8945.0, 11518.308901465854, 40516.39225411621, 41436.964075898046, 41462.79268603668, 41582.633823448705, 41720.0, 3207.4386982278243, 3311.2549676322874, 3463.965360346415, 3559.875404360835, 3973.927039699294, 27377.31556711078, 27569.586456203175, 27597.172084837486, 27633.447331053267, 27855.442891142266, 2674.358154043035, 2690.2870739254113, 2698.3254186453387, 2713.7150599187, 2810.0726760169096, 441295.0, 442867.0, 444694.7765261185, 444934.0, 445895.0, 36484.08789780277, 37511.0, 62474.0, 62926.0, 63006.0, 36394.45408318877, 36471.0, 36675.083122922144, 36694.633053669124, 36791.63208367882, 15206.08763474195, 15396.0, 15402.46091386796, 15412.46056388021, 15437.536873893801, 12931.5473958411, 13005.943603253229, 13006.934965325112, 13019.804702929463, 13020.0, 7725.22747725223, 7852.84294314122, 8132.837343253102, 8212.096669366365, 8296.377771667148, 2747.5603903375363, 3166.859930425045, 3343.4650455926935, 3351.4470112431177, 3379.6113446953914, 902.4089221559889, 1001.8228581416806, 1061.7451811565168, 1066.7279843639822, 1113.9387333696725, 29870.25324366865, 29883.25291867677, 30514.54228186579, 30719.385612288075, 30922.0, 1066.8506409102731, 1094.6223552874246, 1102.862142232221, 1104.2932523185168, 1170.0054953289805, 14558.927205363905, 15568.455104071303, 15580.00089717831, 15884.126373049594, 15907.0455772654, 644282.0, 650531.0, 657579.0, 658457.0, 671100.0, 60974.0, 62013.0, 62061.0, 62125.68937155376, 62408.06387904185, 1332.5602551158095, 1494.3648949196547, 1501.7522108852136, 1511.7203317386318, 1554.7901033360579, 27087.45825083527, 28727.856360718062, 29261.41477170402, 29294.7070529292, 29348.41303173882, 49616.0, 50139.0, 50247.995040099726, 50260.748696257746, 50433.0, 430896.0, 436036.8198158989, 438862.0, 439796.0, 439846.0, 22751.0, 27296.454070918866, 27781.861090694416, 27798.0, 27867.303317417227, 44313.77843110764, 45469.0, 45817.854553636425, 46231.0, 47701.0, 37630.811845940596, 37684.05789855166, 37880.43179352367, 38191.19048688407, 38405.6159438402, 33034.66965330316, 34126.0, 37430.62569374272, 37636.05909852275, 38129.42805857859, 36644.63355366412, 36726.0, 36904.0, 37401.0, 37740.62259377371, 32311.51532727058, 32438.026859194262, 32875.17812054718, 32978.505322420664, 33409.997700069034, 21136.0, 23320.599646913895, 24404.63393049141, 24671.259862204162, 24880.004799807804], "value": 18573.763705205114, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.8958825911134, 394.77497826239045, 399.325140512534, 402.2136722707108, 410.4028638331228, 13866.0, 20001.999900005016, 20656.48358791031, 20766.89616551917, 20776.584468310626, 15908.284127214274, 17277.0, 19770.81375117494, 20240.797592024075, 20689.58620827586, 5813.73838177282, 5998.9700051499685, 6020.939790602104, 6033.185519954815, 6033.818985430422, 5684.886302273952, 5895.734691938852, 5906.4093590640805, 5942.465178133967, 5991.970040149815, 5003.399592048941, 5859.267591551056, 5864.06175011996, 5875.559333050017, 5899.32157801854, 5704.11586204139, 5816.651000939957, 5917.852053698649, 5925.585209035369, 5930.644161350289, 5204.8178313758835, 5219.295395121648, 5220.791168353261, 5221.1124108901195, 5224.8693782655355, 23650.172243971378, 24708.382290442703, 25841.483170336676, 25897.870510647324, 25922.351941201432, 1780.3323753592404, 2120.526234267185, 2227.866328020324, 2231.141010710872, 2420.673209116764, 12045.217060891102, 14655.560333189915, 14766.704665906622, 14890.255487225595, 15243.314050867737, 1638.3200971596773, 1672.4480921296065, 1706.300416829094, 1738.3568079810425, 1760.2430954689478, 114559.0, 118496.0, 119066.0, 119207.0, 121919.0, 10400.323978941344, 10822.296550724177, 10860.294080884718, 10869.619563315246, 11096.223264371578, 13600.115992460458, 13696.178229306273, 13723.862761372258, 13732.107413018322, 13741.931290343684, 6865.9313406866295, 7082.433405327562, 7219.60292183935, 8021.598920053974, 8540.615672294762, 8392.328613710888, 8586.797848301243, 8617.526036067951, 8735.65057397697, 8763.386562940534, 5327.7336133193185, 6357.205349331333, 6479.222493300834, 6487.902681459782, 6565.770198043046, 1600.8639265662316, 1849.6115815678588, 1883.2561138350275, 1887.1507821480388, 1889.9055047247857, 889.3907673243849, 925.6300675001036, 957.2581249531669, 1039.8561582259606, 1040.1003132290514, 16073.598160046093, 20582.485437864172, 20712.99661549067, 20768.169273229203, 21293.0, 868.3140319147928, 915.2769312243387, 931.4923366765129, 954.231843366097, 970.1801977329145, 9222.953885230665, 10122.544485498023, 10213.948930255301, 10247.0, 10416.270861039806, 557276.0, 558324.0, 561569.0, 566023.0, 619468.9026554838, 126998.0, 132920.67079329275, 136646.0, 136878.0, 141319.29340353233, 1007.808516381885, 1025.646152077532, 1049.79004199162, 1055.2191378379944, 1055.3773273768513, 13576.93211533936, 17686.557836054202, 17690.734638980168, 18039.458816235532, 18191.363302284357, 47178.528214717415, 50597.74701126618, 52927.20609190942, 52948.94102118013, 53197.734011329696, 76037.61981190059, 76240.23759762332, 77603.44793104219, 80004.79992799996, 83510.0, 6364.427201551883, 7721.343685786546, 7761.495502792301, 7878.448508604342, 7951.204879512003, 10971.50628221716, 12158.297838302467, 12288.508459661514, 12568.434420450918, 12569.497220111092, 10616.575336986434, 10739.087177589992, 10800.0, 10909.618163364245, 11006.614768483065, 10417.47912604382, 10472.790544189225, 10547.736306592089, 10756.677299681021, 10824.4046577439, 7614.619269036637, 10372.222083343628, 10511.789764204826, 11087.44562771842, 11159.051480624237, 7762.883556746766, 7763.0, 7996.20037996219, 7998.680052797823, 8074.0, 9073.13805188506, 10200.0, 10259.0, 10316.587336506456, 10316.793664126826], "value": 9446.33118079448, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1425.15203453945, 1624.236608793867, 1631.8368163183684, 1901.3630433804674, 2025.6151331247072, 7951.085625153102, 8666.306695464356, 8849.513276769776, 8883.55582220888, 8909.821803563933, 8479.194476524735, 8726.301895848334, 8737.95631021844, 8740.519271440084, 8742.825143497143, 2144.9785502145014, 2218.5784700906856, 2388.8447250928634, 2439.377958620549, 2474.8886300116537, 2441.548313561988, 2463.3964678653756, 2463.6181391884197, 2464.0759715106833, 2475.5296493666237, 2421.806255499556, 2453.0555736041665, 2475.4059025833762, 2476.071473197551, 2485.291691867818, 2073.668213085914, 2345.636426353918, 2417.093589903786, 2433.85396876188, 2435.305937807725, 2433.671454353675, 2444.69441319835, 2452.1662634704107, 2456.7911727503183, 2461.6307553866886, 8697.826043479095, 8705.173008564176, 8740.169683880022, 8770.649174033031, 8790.956045219797, 5203.713795741271, 5372.865678358034, 5380.784768609251, 5385.838424847261, 5401.459854014606, 3380.138064793462, 3398.8300584970652, 3616.1321282891918, 3623.058004918714, 3627.7279204059537, 995.4624502768569, 999.5901680311038, 999.975000624983, 1010.8231059564547, 1016.4206402350663, 11697.590584329593, 11736.178467507278, 11757.647270581896, 11762.294262344201, 11763.294202347886, 4745.1695953208055, 4780.122302942599, 4796.472388037313, 4923.77842997066, 4935.0, 10011.599536018623, 10092.848607270897, 10097.848532272023, 10099.848502272473, 10108.797824043479, 5438.864028399322, 5439.864003399946, 5449.536789372868, 5457.345118585716, 5484.588655850827, 4285.335772955197, 4424.646028317791, 4579.22153233951, 4600.861974140781, 4976.178930476503, 3746.6066063062985, 4131.5455299916985, 4133.111381053028, 4142.881422016099, 4167.958320416757, 1166.4692564882957, 1319.188698950158, 1360.5646193218074, 1363.2093385836192, 1373.9313034348243, 910.8269428808505, 934.6588495199203, 937.4515908193783, 955.1690029674089, 989.5942663507927, 5029.7736601853, 5978.970105149447, 5995.460408563163, 6112.266528016667, 6142.017277235621, 438.4300409467679, 438.73018093872037, 451.56649616368, 457.16795432313535, 457.4145094279328, 3575.249197668467, 3623.2934577757082, 3999.6000399960353, 4021.4571032910767, 4093.8771836844944, 10339.9483002586, 10585.259031867696, 10792.028717415471, 10798.190135739695, 10943.83584246237, 10746.892531074745, 10819.729506762395, 10823.729406764895, 10832.079273261861, 10951.178661600412, 6570.244421891448, 8073.394495412867, 8201.384896132813, 8344.415890887702, 8589.840371549886, 5222.634415590872, 5847.152162936265, 5958.374370691015, 6009.579329446897, 6105.3873105076445, 9902.158316542886, 9954.900450995687, 10038.498075096362, 10048.397096174253, 10055.19558435338, 9726.416415015121, 9939.900600993897, 10126.797464050826, 10128.189744820249, 10286.742831429274, 6813.931860681329, 7081.964590177016, 7497.475176737794, 7594.696212151673, 7594.936708860653, 8094.311983481234, 8383.41316107891, 8390.916090839257, 8393.496390216607, 8394.45436046655, 7172.641367931687, 7332.30343117403, 7346.191918889025, 7473.364763995121, 7501.62491875415, 7113.75101871432, 7256.7822965311125, 7338.816529586589, 7388.741394051182, 7425.591592462466, 7011.193712723102, 7112.217656057933, 7114.217436081924, 7120.430365570845, 7124.715011399486, 4814.831480898151, 4889.706617602955, 4928.088303663833, 5061.519155680205, 5121.206213036985, 4820.25286080658, 4974.179260422135, 4997.5002499749735, 5157.07172708916, 5298.28473156119], "value": 4525.740859515877, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.4412058295068, 316.1022695544653, 326.5053444032292, 328.93256882339125, 330.37723890466464, 4385.539518350575, 5876.147958546014, 5940.257467816523, 5941.732622032008, 6005.4895333896675, 4763.404574428197, 5890.587658863881, 5898.115282707596, 5907.430267833495, 5969.671668058255, 4332.090261045184, 4498.280275155976, 4500.347449619803, 4519.118771839484, 4523.5024147343765, 4158.688098392618, 4421.646268298545, 4422.18189634917, 4513.593776560109, 4518.3222516622445, 3966.841326346943, 4312.417823593822, 4339.088791353819, 4371.65026797857, 4374.759388233646, 3624.0, 4377.4528183977, 4380.737155770648, 4392.868213953587, 4400.0, 3530.382183117944, 3787.9393769744515, 3793.336166170909, 3793.3551296279697, 3807.485989391452, 5631.64840438296, 5674.943250567483, 5680.829575112753, 5688.0, 5705.62913410627, 4780.306855505967, 5035.482258870565, 5036.370453693288, 5058.0, 5079.0, 5792.073268277098, 5811.012127938261, 5969.313528944183, 6203.16257305267, 6237.500999919996, 4102.794860257005, 4105.507339119325, 4118.464599602063, 4134.710570260083, 4135.8966025849595, 6228.252609686821, 6260.780872669435, 6433.517486188554, 6503.577267477599, 6600.834979125512, 3423.0, 3866.7873266970023, 3985.720999530005, 4067.084905896209, 4187.853425130106, 3294.9950265168873, 4231.724937879028, 4242.44848169736, 4274.145170965757, 4294.0767734937135, 4444.533324000998, 5003.999200159982, 5024.472430394829, 5024.598032157419, 5054.368203974504, 5032.0690672225755, 5188.507091826271, 6023.397660233942, 6306.3378345274, 6322.810315690536, 1279.5777393460137, 1303.2310936547483, 1413.321605629283, 1450.6735984403635, 1478.2830327291256, 928.4568527411404, 957.8850537935492, 960.1838437328215, 970.6505657963128, 975.9219262458986, 4783.019481006455, 5774.220480235114, 5819.679917604488, 5820.621659592113, 5846.269216347957, 6463.15978922737, 6477.449416799531, 6482.351764823574, 6493.415592596689, 6535.836604084936, 5574.386817450078, 5772.595918285764, 5794.159846822272, 5805.651660900275, 5805.7387417566315, 2832.8158669686404, 3388.0, 3391.4743214801747, 3420.196253880336, 3421.555197824267, 5264.368275806928, 5810.389909059572, 6001.609895356788, 6718.596884186964, 6789.6605169741315, 6288.119663247149, 6734.393904548516, 6740.090087838079, 6758.336747644208, 6764.255931847493, 6524.412802847766, 6819.931800682029, 6852.965735171392, 6864.24493305736, 6875.278095799869, 5178.249153872743, 5335.226392173191, 6146.477549408351, 6393.968030159819, 6545.14913061299, 5596.916046259228, 6090.670663169726, 6458.61248325102, 6463.385978332051, 6471.514636402195, 6250.218722659668, 6401.455876250571, 6790.898136528055, 6827.761028363983, 6853.246142924374, 3517.771344862576, 3601.585817631006, 3762.1347090168865, 4214.726042807208, 4230.0905305358265, 6255.624662520263, 6560.343965603402, 6575.112359831362, 6575.704093315717, 6579.276279609335, 5202.115640341227, 6298.748050077946, 6342.746290148342, 6360.713767880364, 6429.421352078149, 5589.413111623384, 5925.903707814068, 6331.683415829098, 6339.2392912850755, 6349.174607301022, 5132.666376685504, 5425.636105614386, 5929.080992446177, 6178.876422471435, 6215.9378406215355, 5226.66026708278, 6245.7189426476825, 6282.246130464374, 6331.366863313632, 6339.873202536016, 5422.430644782399, 5933.436323549256, 6189.938100618936, 6197.1324014638885, 6212.720427580679], "value": 4505.307090975169, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.3329554024963, 646.712213065186, 682.7985744205456, 730.2077246187886, 736.924090827392, 14790.704185916275, 15210.087394756323, 15238.542843714678, 15245.93278470506, 15254.847451525482, 12795.744085118293, 13674.111182773138, 13847.792283115736, 13918.930405347985, 13923.860761392383, 917.2799352508266, 924.7040946896996, 935.7988032572996, 936.4381371177308, 936.66748304352, 923.1184219070805, 928.2620316848122, 929.4794914847673, 929.6188562689299, 931.455098767222, 982.3958265666635, 985.9852102218473, 986.7039888033597, 988.3970777825521, 989.0208693393561, 979.7697541077841, 980.0983095552109, 981.219930155521, 982.9017098290185, 983.4984158079395, 731.1299553531334, 731.3052600029993, 731.5281643340016, 732.2165283147035, 733.3216774483582, 13104.475820967149, 13142.0, 13164.0, 13173.34133293341, 13207.801882971764, 11143.944280278627, 11242.943785281102, 11303.208775385727, 11516.251443656136, 11671.474783634672, 9091.454512729257, 9244.352895297332, 9300.20948219402, 9325.906740932573, 9386.014468480847, 3377.257003459235, 3407.71034462071, 3426.811525366104, 3487.8604855805993, 3611.1523795374583, 63713.68143159301, 71639.28360716379, 72704.6364768178, 79057.0, 79147.0, 9545.331826772059, 9669.758256043655, 9856.50717464124, 9965.302428830057, 10575.41835199056, 21786.673199902016, 22075.66886496704, 22129.557408852055, 22131.668024979637, 22149.446263843533, 7505.924940750632, 7630.694772209161, 7644.273793989562, 7779.416543759241, 7940.642671079815, 4057.736247143926, 4125.64931980779, 4133.648639865585, 4178.540360560397, 4428.269335559597, 3458.8616455341503, 3515.54297941266, 3525.4888041233876, 3527.894163175109, 3530.7881527108457, 637.388107416885, 644.2848438233557, 646.8641585267146, 650.9349065093453, 666.9966650166815, 532.7442827442771, 556.210181542211, 573.1116769008021, 576.331455511613, 592.2626330218905, 7739.845203095907, 7813.882791758128, 7869.134395216522, 7880.921190788134, 7908.644111015018, 553.8766410701015, 581.9301683797971, 588.4115884115885, 600.0429315242181, 612.9601575897552, 3661.835217415223, 3758.4362345648374, 3768.510093687803, 3774.54705435344, 3781.4516895050065, 81878.59060704659, 83270.0, 84031.0, 84096.57951710203, 89730.55134724284, 66430.00354994582, 73208.63395682987, 74079.62960185164, 74523.0, 75577.62211188908, 54105.45894541083, 56462.58843528945, 71153.64423177851, 71290.57418851594, 71500.0, 8169.918300816916, 8189.462162296774, 8225.0, 8295.668173273243, 8404.033536143423, 44253.336199956386, 44296.33555496734, 44620.77689611531, 45905.54094459146, 45993.31010034919, 54681.72659136679, 65030.0, 65276.34723652703, 65537.0, 65622.0, 10712.982266684965, 10714.303570267908, 10771.676849694522, 10950.45247737594, 10966.451677416257, 11790.056795456514, 11830.40847957616, 11859.703507412383, 11963.342016189194, 12800.74398512043, 9845.45849978258, 10384.636537721144, 10406.0, 10958.178136639624, 10968.835467468154, 9963.352382095141, 10168.186545076524, 10170.288079834636, 10268.281220314506, 10491.842622360518, 7965.800854978672, 9542.141207291377, 9762.121409072934, 10016.64941727036, 10320.329178603366, 8656.307495400228, 8662.82674346497, 8963.05887881763, 9054.230390416626, 9385.571979593158, 7572.545647261182, 8036.879446808186, 8169.183081692021, 8358.95820520918, 8996.505192214228], "value": 6661.390037301531, "unit": "score"}], "name": "dromaeo_css", "value": 7165.433649281962, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 112.0, 113.0, 110.0, 111.0, 118.0, 111.0, 112.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 121.0, 144.0, 172.0, 121.0, 141.0, 144.0, 122.0, 171.0, 119.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 184.0, 186.0, 185.0, 179.0, 183.0, 180.0, 184.0, 183.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 90.0, 93.0, 55.0, 59.0, 58.0, 79.0, 84.0, 45.0], "value": 71.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 129.0, 175.0, 112.0, 86.0, 83.0, 116.0, 76.0, 79.0, 115.0], "value": 106.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 89.0, 131.0, 117.0, 87.0, 84.0, 86.0, 86.0], "value": 94.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 94.0, 93.0, 92.0, 93.0, 92.0, 101.0, 94.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 86.0, 85.0, 84.0, 85.0, 85.0, 86.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 61.0, 58.0, 60.0, 59.0, 61.0, 81.0, 60.0, 59.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 74.0, 77.0, 77.0, 72.0, 69.0, 67.0, 66.0, 69.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 80.0, 82.0, 83.0, 80.0, 80.0, 81.0, 82.0, 83.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 137.0, 137.0, 145.0, 150.0, 150.0, 157.0, 187.0, 142.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 170.0, 224.0, 221.0, 173.0, 170.0, 170.0, 168.0, 167.0, 174.0], "value": 181.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 71.0, 67.0, 69.0, 70.0, 67.0, 67.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1499.0, "alertThreshold": 2.0}]} 11:50:59 INFO - Return code: 0 11:50:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:50:59 ERROR - # TBPL SUCCESS # 11:50:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:50:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:50:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:50:59 INFO - 2016-04-22 11:50:59.168 screenresolution[1676:9936] starting screenresolution argv=screenresolution get 11:50:59 INFO - 2016-04-22 11:50:59.170 screenresolution[1676:9936] Display 0: 1600x1200x32@60 11:50:59 INFO - 2016-04-22 11:50:59.176 screenresolution[1677:9939] starting screenresolution argv=screenresolution list 11:50:59 INFO - Available Modes on Display 0 11:50:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:50:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:50:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:50:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:50:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:50:59 INFO - Intel Iris: 11:50:59 INFO - Chipset Model: Intel Iris 11:50:59 INFO - Type: GPU 11:50:59 INFO - Bus: Built-In 11:50:59 INFO - VRAM (Dynamic, Max): 1536 MB 11:50:59 INFO - Vendor: Intel (0x8086) 11:50:59 INFO - Device ID: 0x0a2e 11:50:59 INFO - Revision ID: 0x0009 11:50:59 INFO - Displays: 11:50:59 INFO - Display: 11:50:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:50:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:50:59 INFO - Display Serial Number: 1600x1200 60 11:50:59 INFO - Main Display: Yes 11:50:59 INFO - Mirror: Off 11:50:59 INFO - Online: Yes 11:50:59 INFO - Rotation: Supported 11:50:59 INFO - Return code: 0 11:50:59 INFO - Running post-action listener: _resource_record_post_action 11:50:59 INFO - Running post-run listener: _resource_record_post_run 11:51:00 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 37860864; Write bytes: 693343744; Read time: 401; Write time: 1923 11:51:00 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 382472704; Write bytes: 376113152; Read time: 28363; Write time: 705 11:51:00 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 35997184; Write bytes: 295341568; Read time: 377; Write time: 1172 11:51:00 INFO - Running post-run listener: _upload_blobber_files 11:51:00 INFO - Blob upload gear active. 11:51:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:51:00 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 11:51:00 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'] 11:51:00 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 11:51:00 INFO - (blobuploader) - INFO - Open directory for files ... 11:51:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:51:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:51:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:02 INFO - (blobuploader) - INFO - Done attempting. 11:51:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:51:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:51:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:03 INFO - (blobuploader) - INFO - Done attempting. 11:51:03 INFO - (blobuploader) - INFO - Iteration through files over. 11:51:03 INFO - Return code: 0 11:51:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:51:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:51:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/315467f0da61a5a7cebcdf85d5bc80eac56c2c0685c8ad0fa0d84991498856012ed62dc80dc3d58b242adf3042c347cc89d9cd8450b9081a9653cd4624d84b9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2821d34e6b6891a49068577d4c6b5d99039a0d19dddc86e192132ff96c5317935a0838101ceafddb1ca58a00df3cbcbd17d1117f826158918a362e0dcc13c32"} 11:51:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:51:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:51:03 INFO - Contents: 11:51:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/315467f0da61a5a7cebcdf85d5bc80eac56c2c0685c8ad0fa0d84991498856012ed62dc80dc3d58b242adf3042c347cc89d9cd8450b9081a9653cd4624d84b9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2821d34e6b6891a49068577d4c6b5d99039a0d19dddc86e192132ff96c5317935a0838101ceafddb1ca58a00df3cbcbd17d1117f826158918a362e0dcc13c32"} 11:51:03 INFO - Running post-run listener: copy_logs_to_upload_dir 11:51:03 INFO - Copying logs to upload dir... 11:51:03 INFO - mkdir: /builds/slave/test/build/upload/logs 11:51:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.756155 ========= master_lag: 3.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-04-22 11:51:06.110308) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 11:51:06.113764) ========= 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.GwceeB7Z1i/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.XgKuWNiclA/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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/315467f0da61a5a7cebcdf85d5bc80eac56c2c0685c8ad0fa0d84991498856012ed62dc80dc3d58b242adf3042c347cc89d9cd8450b9081a9653cd4624d84b9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2821d34e6b6891a49068577d4c6b5d99039a0d19dddc86e192132ff96c5317935a0838101ceafddb1ca58a00df3cbcbd17d1117f826158918a362e0dcc13c32"} build_url:https://queue.taskcluster.net/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011078 build_url: 'https://queue.taskcluster.net/v1/task/eWQiU2aCQjep-ZdEYbbT1g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/315467f0da61a5a7cebcdf85d5bc80eac56c2c0685c8ad0fa0d84991498856012ed62dc80dc3d58b242adf3042c347cc89d9cd8450b9081a9653cd4624d84b9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2821d34e6b6891a49068577d4c6b5d99039a0d19dddc86e192132ff96c5317935a0838101ceafddb1ca58a00df3cbcbd17d1117f826158918a362e0dcc13c32"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 11:51:06.157317) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:51:06.157688) ========= 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.GwceeB7Z1i/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.XgKuWNiclA/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.004413 ========= master_lag: 0.17 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:51:06.333743) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 11:51:06.334117) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 11:51:06.337633) ========= ========= Total master_lag: 3.57 =========