builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0107 starttime: 1457004133.38 results: success (0) buildid: 20160303022931 builduid: 8691b3aeb155438d940f17c23b289b44 revision: ca53292a4ca31712c9c826296d90d231f8a0bca2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 03:22:13.381473) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 03:22:13.382032) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 03:22:13.382395) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TbKvobWd8A/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.oiLxRLFKZd/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005744 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 03:22:13.409802) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 03:22:13.410242) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 03:22:13.427697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 03:22:13.428249) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TbKvobWd8A/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.oiLxRLFKZd/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.005671 ========= master_lag: 0.58 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 03:22:14.015783) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 03:22:14.019107) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 03:22:14.019522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 03:22:14.019847) ========= 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.TbKvobWd8A/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.oiLxRLFKZd/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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-03-03 03:22:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.76M=0.001s 2016-03-03 03:22:14 (9.76 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096887 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 03:22:14.132648) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-03 03:22:14.133022) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TbKvobWd8A/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.oiLxRLFKZd/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.025804 ========= master_lag: 3.53 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-03 03:22:17.691776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 03:22:17.692134) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ca53292a4ca31712c9c826296d90d231f8a0bca2 --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 ca53292a4ca31712c9c826296d90d231f8a0bca2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TbKvobWd8A/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.oiLxRLFKZd/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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-03-03 03:22:17,770 truncating revision to first 12 chars 2016-03-03 03:22:17,770 Setting DEBUG logging. 2016-03-03 03:22:17,770 attempt 1/10 2016-03-03 03:22:17,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ca53292a4ca3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 03:22:19,467 unpacking tar archive at: fx-team-ca53292a4ca3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.958179 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 03:22:19.668992) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 4 secs) (at 2016-03-03 03:22:19.672370) ========= echo ca53292a4ca31712c9c826296d90d231f8a0bca2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ca53292a4ca31712c9c826296d90d231f8a0bca2'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TbKvobWd8A/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.oiLxRLFKZd/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 ca53292a4ca31712c9c826296d90d231f8a0bca2 program finished with exit code 0 elapsedTime=0.005105 script_repo_revision: 'ca53292a4ca31712c9c826296d90d231f8a0bca2' ========= master_lag: 4.10 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 4 secs) (at 2016-03-03 03:22:23.778015) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 03:22:23.778356) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 03:22:23.804291) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-03 03:22:23.804592) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.TbKvobWd8A/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.oiLxRLFKZd/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:22:23 INFO - MultiFileLogger online at 20160303 03:22:23 in /builds/slave/test 03:22:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 03:22:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:22:23 INFO - {'append_to_log': False, 03:22:23 INFO - 'base_work_dir': '/builds/slave/test', 03:22:23 INFO - 'blob_upload_branch': 'Fx-Team', 03:22:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:22:23 INFO - 'branch': 'Fx-Team', 03:22:23 INFO - 'buildbot_json_path': 'buildprops.json', 03:22:23 INFO - 'config_files': ('talos/mac_config.py',), 03:22:23 INFO - 'default_actions': ('clobber', 03:22:23 INFO - 'read-buildbot-config', 03:22:23 INFO - 'download-and-extract', 03:22:23 INFO - 'populate-webroot', 03:22:23 INFO - 'create-virtualenv', 03:22:23 INFO - 'install', 03:22:23 INFO - 'run-tests'), 03:22:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:22:23 INFO - 'download_minidump_stackwalk': True, 03:22:23 INFO - 'download_symbols': 'ondemand', 03:22:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:22:23 INFO - 'tooltool.py': '/tools/tooltool.py', 03:22:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:22:23 INFO - '/tools/misc-python/virtualenv.py')}, 03:22:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:22:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:22:23 INFO - 'installer_path': 'installer.exe', 03:22:23 INFO - 'log_level': 'info', 03:22:23 INFO - 'log_name': 'talos', 03:22:23 INFO - 'log_to_console': True, 03:22:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:22:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:22:24 INFO - 'opt_config_files': (), 03:22:24 INFO - 'pip_index': False, 03:22:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:22:24 INFO - 'cmd': ('bash', 03:22:24 INFO - '-c', 03:22:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:22:24 INFO - 'enabled': True, 03:22:24 INFO - 'halt_on_failure': False, 03:22:24 INFO - 'name': 'check_screen_resolution'},), 03:22:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:22:24 INFO - 'cmd': ('bash', 03:22:24 INFO - '-c', 03:22:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:22:24 INFO - 'enabled': True, 03:22:24 INFO - 'halt_on_failure': False, 03:22:24 INFO - 'name': 'check_screen_resolution'},), 03:22:24 INFO - 'run_cmd_checks_enabled': True, 03:22:24 INFO - 'sps_profile': False, 03:22:24 INFO - 'sps_profile_interval': 0, 03:22:24 INFO - 'suite': 'dromaeojs-e10s', 03:22:24 INFO - 'system_bits': '32', 03:22:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:22:24 INFO - 'title': 't-yosemite-r7-0107', 03:22:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:22:24 INFO - 'use_talos_json': True, 03:22:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:22:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:22:24 INFO - 'work_dir': 'build'} 03:22:24 INFO - ##### 03:22:24 INFO - ##### Running clobber step. 03:22:24 INFO - ##### 03:22:24 INFO - Running pre-action listener: _resource_record_pre_action 03:22:24 INFO - Running main action method: clobber 03:22:24 INFO - rmtree: /builds/slave/test/build 03:22:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:22:25 INFO - Running post-action listener: _resource_record_post_action 03:22:25 INFO - ##### 03:22:25 INFO - ##### Running read-buildbot-config step. 03:22:25 INFO - ##### 03:22:25 INFO - Running pre-action listener: _resource_record_pre_action 03:22:25 INFO - Running main action method: read_buildbot_config 03:22:25 INFO - Using buildbot properties: 03:22:25 INFO - { 03:22:25 INFO - "project": "", 03:22:25 INFO - "product": "firefox", 03:22:25 INFO - "script_repo_revision": "production", 03:22:25 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 03:22:25 INFO - "repository": "", 03:22:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 03:22:25 INFO - "buildid": "20160303022931", 03:22:25 INFO - "pgo_build": "False", 03:22:25 INFO - "basedir": "/builds/slave/test", 03:22:25 INFO - "buildnumber": 445, 03:22:25 INFO - "slavename": "t-yosemite-r7-0107", 03:22:25 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:22:25 INFO - "platform": "yosemite_r7", 03:22:25 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:22:25 INFO - "branch": "fx-team", 03:22:25 INFO - "repo_path": "integration/fx-team", 03:22:25 INFO - "revision": "ca53292a4ca31712c9c826296d90d231f8a0bca2", 03:22:25 INFO - "stage_platform": "macosx64", 03:22:25 INFO - "builduid": "8691b3aeb155438d940f17c23b289b44", 03:22:25 INFO - "slavebuilddir": "test" 03:22:25 INFO - } 03:22:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 03:22:25 INFO - Running post-action listener: _resource_record_post_action 03:22:25 INFO - ##### 03:22:25 INFO - ##### Running download-and-extract step. 03:22:25 INFO - ##### 03:22:25 INFO - Running pre-action listener: _resource_record_pre_action 03:22:25 INFO - Running main action method: download_and_extract 03:22:25 INFO - mkdir: /builds/slave/test/build/tests 03:22:25 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')]} 03:22:25 INFO - https://queue.taskcluster.net/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:22:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 03:22:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 03:22:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 03:22:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 03:22:26 INFO - Downloaded 1277 bytes. 03:22:26 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 03:22:27 INFO - Using the following test package requirements: 03:22:27 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:22:27 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:22:27 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 03:22:27 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:22:27 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 03:22:27 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:22:27 INFO - u'jsshell-mac.zip'], 03:22:27 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:22:27 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 03:22:27 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:22:27 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:22:27 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 03:22:27 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:22:27 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 03:22:27 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:22:27 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 03:22:27 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:22:27 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:22:27 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 03:22:27 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:27 INFO - https://queue.taskcluster.net/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:22:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:22:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:22:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:22:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:22:28 INFO - Downloaded 17855010 bytes. 03:22:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:22:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:22:31 INFO - Return code: 0 03:22:31 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:22: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')]} 03:22:31 INFO - https://queue.taskcluster.net/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:22:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:22:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:22:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:22:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:22:35 INFO - Downloaded 17855010 bytes. 03:22:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:22:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:22:38 INFO - Return code: 0 03:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:38 INFO - https://queue.taskcluster.net/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:22:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:22:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:22:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:22:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:22:39 INFO - Downloaded 10808263 bytes. 03:22:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:22:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:22:40 INFO - Return code: 0 03:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:40 INFO - https://queue.taskcluster.net/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:22:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:22:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:22:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 03:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 03:22:45 INFO - Downloaded 110898239 bytes. 03:22:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:22:45 INFO - mkdir: /builds/slave/test/properties 03:22:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:22:45 INFO - Writing to file /builds/slave/test/properties/build_url 03:22:45 INFO - Contents: 03:22:45 INFO - build_url:https://queue.taskcluster.net/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:22:46 INFO - Running post-action listener: _resource_record_post_action 03:22:46 INFO - Running post-action listener: set_extra_try_arguments 03:22:46 INFO - ##### 03:22:46 INFO - ##### Running populate-webroot step. 03:22:46 INFO - ##### 03:22:46 INFO - Running pre-action listener: _resource_record_pre_action 03:22:46 INFO - Running main action method: populate_webroot 03:22:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:22:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:22:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:22:46 INFO - '--tppagecycles', 03:22:46 INFO - '7'], 03:22:46 INFO - 'tests': ['tsvgm']}}, 03:22:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:22:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:22:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:22:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:22:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:22:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:22:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:46 INFO - 'talos_options': ['--e10s'], 03:22:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:46 INFO - 'tests': ['damp', 'tps']}, 03:22:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:46 INFO - 'talos_options': ['--e10s'], 03:22:46 INFO - 'tests': ['damp', 'tps']}, 03:22:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:22:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:46 INFO - 'other': {'tests': ['a11yr', 03:22:46 INFO - 'ts_paint', 03:22:46 INFO - 'tpaint', 03:22:46 INFO - 'sessionrestore', 03:22:46 INFO - 'sessionrestore_no_auto_restore']}, 03:22:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:22:46 INFO - 'tests': ['a11yr', 03:22:46 INFO - 'ts_paint', 03:22:46 INFO - 'tpaint', 03:22:46 INFO - 'sessionrestore', 03:22:46 INFO - 'sessionrestore_no_auto_restore']}, 03:22:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:22:46 INFO - 'tests': ['a11yr', 03:22:46 INFO - 'ts_paint', 03:22:46 INFO - 'tpaint', 03:22:46 INFO - 'sessionrestore', 03:22:46 INFO - 'sessionrestore_no_auto_restore']}, 03:22:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:22:46 INFO - 'tests': ['a11yr', 03:22:46 INFO - 'ts_paint', 03:22:46 INFO - 'tpaint', 03:22:46 INFO - 'sessionrestore', 03:22:46 INFO - 'sessionrestore_no_auto_restore']}, 03:22:46 INFO - 'other_l64': {'tests': ['a11yr', 03:22:46 INFO - 'ts_paint', 03:22:46 INFO - 'tpaint', 03:22:46 INFO - 'sessionrestore', 03:22:46 INFO - 'sessionrestore_no_auto_restore']}, 03:22:46 INFO - 'other_nol64': {'tests': ['a11yr', 03:22:46 INFO - 'ts_paint', 03:22:46 INFO - 'tpaint', 03:22:46 INFO - 'sessionrestore', 03:22:46 INFO - 'sessionrestore_no_auto_restore']}, 03:22:46 INFO - 'svgr': {'tests': ['tsvgx', 03:22:46 INFO - 'tsvgr_opacity', 03:22:46 INFO - 'tart', 03:22:46 INFO - 'tscrollx', 03:22:46 INFO - 'cart']}, 03:22:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:22:46 INFO - 'tests': ['tsvgx', 03:22:46 INFO - 'tsvgr_opacity', 03:22:46 INFO - 'tart', 03:22:46 INFO - 'tscrollx', 03:22:46 INFO - 'cart']}, 03:22:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:46 INFO - 'tests': ['tp5o']}, 03:22:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:46 INFO - 'talos_options': ['--e10s'], 03:22:46 INFO - 'tests': ['tp5o']}, 03:22:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:46 INFO - 'talos_options': ['--xperf_path', 03:22:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:46 INFO - 'tests': ['tp5n']}, 03:22:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:46 INFO - 'talos_options': ['--e10s', 03:22:46 INFO - '--xperf_path', 03:22:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:46 INFO - 'tests': ['tp5n']}}, 03:22:46 INFO - 'talos.zip': {'path': '', 03:22:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:22:46 INFO - Running post-action listener: _resource_record_post_action 03:22:46 INFO - ##### 03:22:46 INFO - ##### Running create-virtualenv step. 03:22:46 INFO - ##### 03:22:46 INFO - Running pre-action listener: _resource_record_pre_action 03:22:46 INFO - Running main action method: create_virtualenv 03:22:46 INFO - Creating virtualenv /builds/slave/test/build/venv 03:22:46 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 03:22:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:22:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:46 INFO - Using real prefix '/tools/python27' 03:22:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:22:47 INFO - Installing distribute.............................................................................................................................................................................................done. 03:22:50 INFO - Installing pip.................done. 03:22:50 INFO - Return code: 0 03:22:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:22:50 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')]} 03:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:50 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')]} 03:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:50 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 0x102487a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9c34c9890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232bd30>, '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 0x10214fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102322b20>, '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.TbKvobWd8A/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.oiLxRLFKZd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:22:50 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 03:22:50 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 03:22:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TbKvobWd8A/Render', 03:22:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:50 INFO - 'HOME': '/Users/cltbld', 03:22:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:50 INFO - 'LOGNAME': 'cltbld', 03:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:50 INFO - 'MOZ_NO_REMOTE': '1', 03:22:50 INFO - 'NO_EM_RESTART': '1', 03:22:50 INFO - 'PAGER': '/bin/cat', 03:22:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:50 INFO - 'PWD': '/builds/slave/test', 03:22:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:50 INFO - 'SHELL': '/bin/bash', 03:22:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oiLxRLFKZd/Listeners', 03:22:50 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:22:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:50 INFO - 'USER': 'cltbld', 03:22:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:50 INFO - 'XPC_FLAGS': '0x0', 03:22:50 INFO - 'XPC_SERVICE_NAME': '0', 03:22:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:50 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 03:22:50 INFO - Cleaning up... 03:22:50 INFO - Return code: 0 03:22:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:22:50 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')]} 03:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:50 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')]} 03:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:50 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 0x102487a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9c34c9890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232bd30>, '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 0x10214fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102322b20>, '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.TbKvobWd8A/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.oiLxRLFKZd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:22:50 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 03:22:50 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 03:22:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TbKvobWd8A/Render', 03:22:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:50 INFO - 'HOME': '/Users/cltbld', 03:22:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:50 INFO - 'LOGNAME': 'cltbld', 03:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:50 INFO - 'MOZ_NO_REMOTE': '1', 03:22:50 INFO - 'NO_EM_RESTART': '1', 03:22:50 INFO - 'PAGER': '/bin/cat', 03:22:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:50 INFO - 'PWD': '/builds/slave/test', 03:22:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:50 INFO - 'SHELL': '/bin/bash', 03:22:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oiLxRLFKZd/Listeners', 03:22:50 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:22:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:50 INFO - 'USER': 'cltbld', 03:22:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:50 INFO - 'XPC_FLAGS': '0x0', 03:22:50 INFO - 'XPC_SERVICE_NAME': '0', 03:22:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:50 INFO - Downloading/unpacking psutil>=0.7.1 03:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:22:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:53 INFO - Installing collected packages: psutil 03:22:53 INFO - Running setup.py install for psutil 03:22:53 INFO - building 'psutil._psutil_osx' extension 03:22:53 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 03:22:54 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 03:22:54 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 03:22:54 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 03:22:54 INFO - building 'psutil._psutil_posix' extension 03:22:54 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 03:22:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:22:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:22:54 INFO - ^ 03:22:54 INFO - 1 warning generated. 03:22:54 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 03:22:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:54 INFO - Successfully installed psutil 03:22:54 INFO - Cleaning up... 03:22:54 INFO - Return code: 0 03:22:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:54 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 0x102487a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9c34c9890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232bd30>, '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 0x10214fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102322b20>, '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.TbKvobWd8A/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.oiLxRLFKZd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:22:54 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 03:22:54 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 03:22:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TbKvobWd8A/Render', 03:22:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:54 INFO - 'HOME': '/Users/cltbld', 03:22:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:54 INFO - 'LOGNAME': 'cltbld', 03:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:54 INFO - 'MOZ_NO_REMOTE': '1', 03:22:54 INFO - 'NO_EM_RESTART': '1', 03:22:54 INFO - 'PAGER': '/bin/cat', 03:22:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:54 INFO - 'PWD': '/builds/slave/test', 03:22:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:54 INFO - 'SHELL': '/bin/bash', 03:22:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oiLxRLFKZd/Listeners', 03:22:54 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:22:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:54 INFO - 'USER': 'cltbld', 03:22:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:54 INFO - 'XPC_FLAGS': '0x0', 03:22:54 INFO - 'XPC_SERVICE_NAME': '0', 03:22:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:22:54 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 03:22:54 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 03:22:54 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 03:22:54 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 03:22:54 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 03:22:54 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 03:22:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:22:57 INFO - Installing collected packages: mozsystemmonitor 03:22:57 INFO - Running setup.py install for mozsystemmonitor 03:22:57 INFO - Successfully installed mozsystemmonitor 03:22:57 INFO - Cleaning up... 03:22:57 INFO - Return code: 0 03:22:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:57 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 0x102487a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9c34c9890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232bd30>, '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 0x10214fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102322b20>, '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.TbKvobWd8A/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.oiLxRLFKZd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:22:57 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 03:22:57 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 03:22:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TbKvobWd8A/Render', 03:22:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:57 INFO - 'HOME': '/Users/cltbld', 03:22:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:57 INFO - 'LOGNAME': 'cltbld', 03:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:57 INFO - 'MOZ_NO_REMOTE': '1', 03:22:57 INFO - 'NO_EM_RESTART': '1', 03:22:57 INFO - 'PAGER': '/bin/cat', 03:22:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:57 INFO - 'PWD': '/builds/slave/test', 03:22:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:57 INFO - 'SHELL': '/bin/bash', 03:22:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oiLxRLFKZd/Listeners', 03:22:57 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:22:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:57 INFO - 'USER': 'cltbld', 03:22:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:57 INFO - 'XPC_FLAGS': '0x0', 03:22:57 INFO - 'XPC_SERVICE_NAME': '0', 03:22:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:57 INFO - Downloading/unpacking blobuploader==1.2.4 03:22:57 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 03:22:57 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 03:22:57 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 03:22:57 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 03:22:57 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 03:22:57 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 03:23:00 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23:00 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 03:23:00 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 03:23:00 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 03:23:00 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 03:23:00 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 03:23:00 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 03:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23:00 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 03:23:00 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 03:23:00 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 03:23:00 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 03:23:00 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 03:23:00 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 03:23:01 INFO - Downloading docopt-0.6.1.tar.gz 03:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:01 INFO - Running setup.py install for blobuploader 03:23:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:01 INFO - Running setup.py install for requests 03:23:02 INFO - Running setup.py install for docopt 03:23:02 INFO - Successfully installed blobuploader requests docopt 03:23:02 INFO - Cleaning up... 03:23:02 INFO - Return code: 0 03:23:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:02 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 0x102487a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9c34c9890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232bd30>, '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 0x10214fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102322b20>, '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.TbKvobWd8A/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.oiLxRLFKZd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:23:02 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 03:23:02 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 03:23:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TbKvobWd8A/Render', 03:23:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:02 INFO - 'HOME': '/Users/cltbld', 03:23:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:02 INFO - 'LOGNAME': 'cltbld', 03:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:02 INFO - 'MOZ_NO_REMOTE': '1', 03:23:02 INFO - 'NO_EM_RESTART': '1', 03:23:02 INFO - 'PAGER': '/bin/cat', 03:23:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:02 INFO - 'PWD': '/builds/slave/test', 03:23:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:02 INFO - 'SHELL': '/bin/bash', 03:23:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oiLxRLFKZd/Listeners', 03:23:02 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:23:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:02 INFO - 'USER': 'cltbld', 03:23:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:02 INFO - 'XPC_FLAGS': '0x0', 03:23:02 INFO - 'XPC_SERVICE_NAME': '0', 03:23:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:02 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-7i1LNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:02 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Qb8IwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:02 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-gam3nV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:02 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-fwnrB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:02 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-nB6MQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-CpQqcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-qrTLvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-hLb5tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-JzR9JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ml5qEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ZwkISY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-EObBLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-BUrGQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-2kJJ7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-yBZl6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-h_DlVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-d0zyhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:04 INFO - Running setup.py install for manifestparser 03:23:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:04 INFO - Running setup.py install for mozcrash 03:23:04 INFO - Running setup.py install for mozdebug 03:23:04 INFO - Running setup.py install for mozdevice 03:23:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:23:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:04 INFO - Running setup.py install for mozfile 03:23:05 INFO - Running setup.py install for mozhttpd 03:23:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:05 INFO - Running setup.py install for mozinfo 03:23:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:05 INFO - Running setup.py install for mozInstall 03:23:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:05 INFO - Running setup.py install for mozleak 03:23:05 INFO - Running setup.py install for mozlog 03:23:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:05 INFO - Running setup.py install for moznetwork 03:23:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:05 INFO - Running setup.py install for mozprocess 03:23:06 INFO - Running setup.py install for mozprofile 03:23:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:06 INFO - Running setup.py install for mozrunner 03:23:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:06 INFO - Running setup.py install for mozscreenshot 03:23:06 INFO - Running setup.py install for moztest 03:23:06 INFO - Running setup.py install for mozversion 03:23:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:06 INFO - Cleaning up... 03:23:06 INFO - Return code: 0 03:23:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:06 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 0x102487a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9c34c9890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232bd30>, '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 0x10214fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102322b20>, '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.TbKvobWd8A/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.oiLxRLFKZd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:23:06 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 03:23:06 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 03:23:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TbKvobWd8A/Render', 03:23:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:06 INFO - 'HOME': '/Users/cltbld', 03:23:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:06 INFO - 'LOGNAME': 'cltbld', 03:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:06 INFO - 'MOZ_NO_REMOTE': '1', 03:23:06 INFO - 'NO_EM_RESTART': '1', 03:23:06 INFO - 'PAGER': '/bin/cat', 03:23:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:06 INFO - 'PWD': '/builds/slave/test', 03:23:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:06 INFO - 'SHELL': '/bin/bash', 03:23:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oiLxRLFKZd/Listeners', 03:23:06 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:23:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:06 INFO - 'USER': 'cltbld', 03:23:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:06 INFO - 'XPC_FLAGS': '0x0', 03:23:06 INFO - 'XPC_SERVICE_NAME': '0', 03:23:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-9KQkP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:07 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)) 03:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-j4_Q3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 03:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-X210ZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:07 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)) 03:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-r4v66V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:07 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)) 03:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-OpW9Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:07 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)) 03:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-PbbNoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:07 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)) 03:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-O9b7Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:07 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)) 03:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-9dCmLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:08 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)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:08 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-M7sjL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:08 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)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:08 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-woZWso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:08 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)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:08 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-xNd2l9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:08 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)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:08 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-FIB_Vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:08 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)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:08 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Uq_c78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:08 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)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:08 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-QSf_7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:08 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)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:08 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-H9I7ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:08 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)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:08 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-UHspYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:08 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)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:08 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Iu87h1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:08 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)) 03:23:08 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:08 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:08 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)) 03:23:08 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)) 03:23:08 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)) 03:23:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:08 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 03:23:08 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 03:23:08 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 03:23:08 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 03:23:08 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 03:23:08 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 03:23:11 INFO - Downloading blessings-1.6.tar.gz 03:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:11 INFO - Installing collected packages: blessings 03:23:11 INFO - Running setup.py install for blessings 03:23:11 INFO - Successfully installed blessings 03:23:11 INFO - Cleaning up... 03:23:11 INFO - Return code: 0 03:23:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:11 INFO - Reading from file tmpfile_stdout 03:23:11 INFO - Current package versions: 03:23:11 INFO - blessings == 1.6 03:23:11 INFO - blobuploader == 1.2.4 03:23:11 INFO - docopt == 0.6.1 03:23:11 INFO - manifestparser == 1.1 03:23:11 INFO - mozInstall == 1.12 03:23:11 INFO - mozcrash == 0.16 03:23:11 INFO - mozdebug == 0.1 03:23:11 INFO - mozdevice == 0.48 03:23:11 INFO - mozfile == 1.2 03:23:11 INFO - mozhttpd == 0.7 03:23:11 INFO - mozinfo == 0.9 03:23:11 INFO - mozleak == 0.1 03:23:11 INFO - mozlog == 3.1 03:23:11 INFO - moznetwork == 0.27 03:23:11 INFO - mozprocess == 0.22 03:23:11 INFO - mozprofile == 0.28 03:23:11 INFO - mozrunner == 6.11 03:23:11 INFO - mozscreenshot == 0.1 03:23:11 INFO - mozsystemmonitor == 0.0 03:23:11 INFO - moztest == 0.7 03:23:11 INFO - mozversion == 1.4 03:23:11 INFO - psutil == 3.1.1 03:23:11 INFO - requests == 1.2.3 03:23:11 INFO - wsgiref == 0.1.2 03:23:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:11 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')]} 03:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:12 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')]} 03:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:12 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 0x102487a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9c34c9890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232bd30>, '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 0x10214fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102322b20>, '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.TbKvobWd8A/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.oiLxRLFKZd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:23:12 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 03:23:12 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 03:23:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TbKvobWd8A/Render', 03:23:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:12 INFO - 'HOME': '/Users/cltbld', 03:23:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:12 INFO - 'LOGNAME': 'cltbld', 03:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:12 INFO - 'MOZ_NO_REMOTE': '1', 03:23:12 INFO - 'NO_EM_RESTART': '1', 03:23:12 INFO - 'PAGER': '/bin/cat', 03:23:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:12 INFO - 'PWD': '/builds/slave/test', 03:23:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:12 INFO - 'SHELL': '/bin/bash', 03:23:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oiLxRLFKZd/Listeners', 03:23:12 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:23:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:12 INFO - 'USER': 'cltbld', 03:23:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:12 INFO - 'XPC_FLAGS': '0x0', 03:23:12 INFO - 'XPC_SERVICE_NAME': '0', 03:23:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:12 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)) 03:23:12 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)) 03:23:12 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)) 03:23:12 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)) 03:23:12 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)) 03:23:12 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)) 03:23:12 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)) 03:23:12 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)) 03:23:12 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)) 03:23:12 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)) 03:23:12 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)) 03:23:12 INFO - Cleaning up... 03:23:12 INFO - Return code: 0 03:23:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23:12 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')]} 03:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:12 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')]} 03:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:12 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 0x102487a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9c34c9890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232bd30>, '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 0x10214fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102322b20>, '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.TbKvobWd8A/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.oiLxRLFKZd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:23:12 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 03:23:12 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 03:23:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TbKvobWd8A/Render', 03:23:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:12 INFO - 'HOME': '/Users/cltbld', 03:23:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:12 INFO - 'LOGNAME': 'cltbld', 03:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:12 INFO - 'MOZ_NO_REMOTE': '1', 03:23:12 INFO - 'NO_EM_RESTART': '1', 03:23:12 INFO - 'PAGER': '/bin/cat', 03:23:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:12 INFO - 'PWD': '/builds/slave/test', 03:23:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:12 INFO - 'SHELL': '/bin/bash', 03:23:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oiLxRLFKZd/Listeners', 03:23:12 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:23:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:12 INFO - 'USER': 'cltbld', 03:23:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:12 INFO - 'XPC_FLAGS': '0x0', 03:23:12 INFO - 'XPC_SERVICE_NAME': '0', 03:23:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:12 INFO - Downloading/unpacking jsonschema 03:23:12 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 03:23:12 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 03:23:12 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 03:23:12 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 03:23:12 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 03:23:12 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 03:23:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:15 INFO - Downloading/unpacking functools32 (from jsonschema) 03:23:15 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 03:23:15 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 03:23:15 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 03:23:15 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 03:23:15 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 03:23:15 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 03:23:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:15 INFO - warning: no files found matching '*.txt' 03:23:15 INFO - no previously-included directories found matching 'build' 03:23:15 INFO - no previously-included directories found matching 'dist' 03:23:15 INFO - no previously-included directories found matching '.git*' 03:23:15 INFO - Installing collected packages: jsonschema, functools32 03:23:15 INFO - Running setup.py install for functools32 03:23:15 INFO - warning: no files found matching '*.txt' 03:23:15 INFO - no previously-included directories found matching 'build' 03:23:15 INFO - no previously-included directories found matching 'dist' 03:23:15 INFO - no previously-included directories found matching '.git*' 03:23:15 INFO - Successfully installed jsonschema functools32 03:23:15 INFO - Cleaning up... 03:23:15 INFO - Return code: 0 03:23:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:23:15 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')]} 03:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:15 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')]} 03:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:15 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 0x102487a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9c34c9890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232bd30>, '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 0x10214fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102322b20>, '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.TbKvobWd8A/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.oiLxRLFKZd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:23:15 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 03:23:15 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 03:23:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TbKvobWd8A/Render', 03:23:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:15 INFO - 'HOME': '/Users/cltbld', 03:23:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:15 INFO - 'LOGNAME': 'cltbld', 03:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:15 INFO - 'MOZ_NO_REMOTE': '1', 03:23:15 INFO - 'NO_EM_RESTART': '1', 03:23:15 INFO - 'PAGER': '/bin/cat', 03:23:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:15 INFO - 'PWD': '/builds/slave/test', 03:23:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:15 INFO - 'SHELL': '/bin/bash', 03:23:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oiLxRLFKZd/Listeners', 03:23:15 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:23:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:15 INFO - 'USER': 'cltbld', 03:23:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:15 INFO - 'XPC_FLAGS': '0x0', 03:23:15 INFO - 'XPC_SERVICE_NAME': '0', 03:23:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:16 INFO - Downloading/unpacking flake8 03:23:16 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 03:23:16 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 03:23:16 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 03:23:16 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 03:23:16 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 03:23:16 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 03:23:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:23:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:23:18 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 03:23:18 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 03:23:18 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 03:23:18 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 03:23:18 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 03:23:18 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 03:23:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:23:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:23:18 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 03:23:18 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 03:23:18 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 03:23:18 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 03:23:18 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 03:23:18 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 03:23:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:23:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:23:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:23:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:23:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:23:19 INFO - no previously-included directories found matching 'docs/_build' 03:23:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:23:19 INFO - Running setup.py install for pep8 03:23:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:23:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:23:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:23:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:23:19 INFO - no previously-included directories found matching 'docs/_build' 03:23:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:23:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:23:20 INFO - Cleaning up... 03:23:20 INFO - Return code: 0 03:23:20 INFO - Running post-action listener: _resource_record_post_action 03:23:20 INFO - Running post-action listener: _start_resource_monitoring 03:23:20 INFO - Starting resource monitoring. 03:23:20 INFO - ##### 03:23:20 INFO - ##### Running install step. 03:23:20 INFO - ##### 03:23:20 INFO - Running pre-action listener: _resource_record_pre_action 03:23:20 INFO - Running main action method: install 03:23:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:20 INFO - Reading from file tmpfile_stdout 03:23:20 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:23:20 INFO - Reading from file tmpfile_stdout 03:23:20 INFO - Output received: 03:23:20 INFO - Usage: mozinstall [options] installer 03:23:20 INFO - Options: 03:23:20 INFO - -h, --help show this help message and exit 03:23:20 INFO - -d DEST, --destination=DEST 03:23:20 INFO - Directory to install application into. [default: 03:23:20 INFO - "/builds/slave/test"] 03:23:20 INFO - --app=APP Application being installed. [default: firefox] 03:23:20 INFO - mkdir: /builds/slave/test/build/application 03:23:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:23:54 INFO - Reading from file tmpfile_stdout 03:23:54 INFO - Output received: 03:23:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:23:54 INFO - Running post-action listener: _resource_record_post_action 03:23:54 INFO - ##### 03:23:54 INFO - ##### Running run-tests step. 03:23:54 INFO - ##### 03:23:54 INFO - Running pre-action listener: _resource_record_pre_action 03:23:54 INFO - Running main action method: run_tests 03:23:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:23:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:23:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:23:54 INFO - 2016-03-03 03:23:54.274 screenresolution[1643:7699] starting screenresolution argv=screenresolution get 03:23:54 INFO - 2016-03-03 03:23:54.277 screenresolution[1643:7699] Display 0: 1600x1200x32@60 03:23:54 INFO - 2016-03-03 03:23:54.283 screenresolution[1644:7701] starting screenresolution argv=screenresolution list 03:23:54 INFO - Available Modes on Display 0 03:23:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:23:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:23:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:23:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:23:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:23:54 INFO - Intel Iris: 03:23:54 INFO - Chipset Model: Intel Iris 03:23:54 INFO - Type: GPU 03:23:54 INFO - Bus: Built-In 03:23:54 INFO - VRAM (Dynamic, Max): 1536 MB 03:23:54 INFO - Vendor: Intel (0x8086) 03:23:54 INFO - Device ID: 0x0a2e 03:23:54 INFO - Revision ID: 0x0009 03:23:54 INFO - Displays: 03:23:54 INFO - Display: 03:23:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:23:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:23:54 INFO - Display Serial Number: 1600x1200 60 03:23:54 INFO - Main Display: Yes 03:23:54 INFO - Mirror: Off 03:23:54 INFO - Online: Yes 03:23:54 INFO - Rotation: Supported 03:23:54 INFO - Return code: 0 03:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:23:54 INFO - Python 2.7.3 03:23:54 INFO - Return code: 0 03:23:54 INFO - grabbing minidump binary from tooltool 03:23: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')]} 03:23:54 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 0x10232bd30>, '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 0x10214fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102322b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:23:54 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 03:23:54 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 03:23:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:23:54 INFO - Return code: 0 03:23:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:23:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:23:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:23:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:23:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:23:55 INFO - Return code: 0 03:23:55 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:23:55 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0107 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:23:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TbKvobWd8A/Render', 03:23:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:55 INFO - 'HOME': '/Users/cltbld', 03:23:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:55 INFO - 'LOGNAME': 'cltbld', 03:23:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:55 INFO - 'MOZ_NO_REMOTE': '1', 03:23:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:55 INFO - 'NO_EM_RESTART': '1', 03:23:55 INFO - 'PAGER': '/bin/cat', 03:23:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:55 INFO - 'PWD': '/builds/slave/test', 03:23:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:55 INFO - 'SHELL': '/bin/bash', 03:23:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oiLxRLFKZd/Listeners', 03:23:55 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:23:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:55 INFO - 'USER': 'cltbld', 03:23:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:55 INFO - 'XPC_FLAGS': '0x0', 03:23:55 INFO - 'XPC_SERVICE_NAME': '0', 03:23:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:23:56 INFO - mozversion application_buildid: 20160303022931 03:23:56 INFO - mozversion application_changeset: ca53292a4ca31712c9c826296d90d231f8a0bca2 03:23:56 INFO - mozversion application_display_name: Nightly 03:23:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:23:56 INFO - mozversion application_name: Firefox 03:23:56 INFO - mozversion application_remotingname: firefox 03:23:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:23:56 INFO - mozversion application_vendor: Mozilla 03:23:56 INFO - mozversion application_version: 47.0a1 03:23:56 INFO - mozversion platform_buildid: 20160303022931 03:23:56 INFO - mozversion platform_changeset: ca53292a4ca31712c9c826296d90d231f8a0bca2 03:23:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:23:56 INFO - mozversion platform_version: 47.0a1 03:23:56 INFO - using testdate: 1457004236 03:23:56 INFO - actual date: 1457004236 03:23:56 INFO - starting webserver on 'localhost:49275' 03:23:56 INFO - SUITE-START | Running 2 tests 03:23:56 INFO - TEST-START | dromaeo_css 03:23:56 INFO - operating with platform_type : mac_ 03:23:56 INFO - Initialising browser for dromaeo_css test... 03:23:56 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpz00zxQ/profile http://localhost:49275/getInfo.html) 03:23:59 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 03:23:59 INFO - PROCESS | 1662 | colorDepth:24 03:23:59 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 03:23:59 INFO - PROCESS | 1662 | __metrics 03:23:59 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:23:59 INFO - TEST-INFO | 1662: exit 0 03:23:59 INFO - Browser initialized. 03:23:59 INFO - Running cycle 1/1 for dromaeo_css test... 03:23:59 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpz00zxQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:11 INFO - PROCESS | 1666 | RSS: Main: 253919232 03:24:11 INFO - PROCESS | 1666 | 03:25:01 INFO - PROCESS | 1666 | 1457004301357 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] 03:27:11 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 03:27:13 INFO - PROCESS | 1666 | RSS: Main: 269758464 03:27:13 INFO - PROCESS | 1666 | 03:30:15 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 03:30:15 INFO - PROCESS | 1666 | RSS: Main: 281731072 03:30:15 INFO - PROCESS | 1666 | 03:33:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 03:33:18 INFO - PROCESS | 1666 | RSS: Main: 282206208 03:33:18 INFO - PROCESS | 1666 | 03:36:19 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 03:36:20 INFO - PROCESS | 1666 | RSS: Main: 283414528 03:36:20 INFO - PROCESS | 1666 | 03:39:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 03:39:23 INFO - PROCESS | 1666 | RSS: Main: 286199808 03:39:23 INFO - PROCESS | 1666 | 03:42:25 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 03:42:26 INFO - PROCESS | 1666 | RSS: Main: 289361920 03:42:26 INFO - PROCESS | 1666 | 03:42:26 INFO - PROCESS | 1666 | __start_tp_report 03:42:26 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 03:42:26 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 03:42:26 INFO - PROCESS | 1666 | |i|pagename|runs| 03:42:26 INFO - PROCESS | 1666 | |0;dojo.html;3475.1138459692775;3593.9640603593957;3616.6564176403267;3645.1616128290493;3662.212624285778;5865.061590145578;5878.441548052933;5906.734196961136;5915.497182739467;5934.703264836762;4961.18140506816;5768.596198266123;5852.239208902847;5949.940500594993;5951.58338916276;5291.2327712481665;5354.22363757255;5385.057614917393;5399.9730001349935;5422.6475279106735;580.2290052776149;5309.230161626562;5355.973220133894;5364.544013758835;5423.918641220384;5318.441563635801;5319.9734001330135;5364;5372.785088596452;5381;5264.341957255343;5367.543758780508;5397.8380648580605;5411.864703382447;5414.593905457106;5250.789968401259;5277.419483856773;5337.759800808973;5353.411124776271;5391.541718953894;5221.668474539007;5339.119045357511;5723.7996670116345;5731.111677689964;5799.681017544033;6170.660613666291;6235.968820155916;6293.087502312139;6319.778807741753;6338.271098823649;5623.831285061414;6226.128342032074;6279.780207692709;6298.3701629837105;6305.9910414333945;5708.343540492855;5987.580869339148;5987.910181347327;5992.13114098462;5995.730192141321;6221.377862213742;6291.402316779899;6301.936980630227;6309.14826498426;6314.305426403092;6206.472449841724;6266.310705822356;6298.496120310364;6311.400416960381;6323.9683801580695;5291.788328466895;6259.342769009279;6270.874582508324;6283.465905398092;6314.526410519229;5277.627816767591;5656.547476201894;6078.331383547807;6215.12988181655;6286.622802631857;5173.861750414902;6198.101275315144;6236.002239641635;6247.718852651642;6284.968575157186;4970.2296144097;4981.576565991932;4985.052839960396;5009.273655319958;5043.974780126149;4473.664475164375;4488.39406680094;4496.865094047183;4526.117407105648;4579.748113853703;5797.333306669702;5873.2658417697785;5892.234009578728;5895.941040589625;5897.823065308047;6227.252729672468;6252.249730032425;6271.686415679198;6288.874222515524;6293.96853015732;5753.626014309057;5832.708364581838;5893.882122357614;5904.380040095728;5963.463288303987;5446.809361672323;5460.945390546123;5482.2873026507095;5486.725663716878;5487.506124448819;6234.314225435108;6390.073439351361;6390.8721825563225;6397.232332120176;6407.871842563122;6221.4089661482085;6250.937490625036;6278.717457714322;6294.15028971083;6307.810765677037;6334.1765570475545;6338.492920566251;6361.332060133619;6366.936330636634;6371.39471750183;6114.144019837316;6229.221347331583;6295.433410993032;6295.685215739286;6313.621182729051;5237.580993520585;6212.347703491068;6273.686315684289;6304.495640348853;6308.432241098323;5756.769729210785;6241.78153764616;6247.2815626201755;6265.937340626718;6285.811425657238;6096.6476373754385;6122.204113465221;6160.075988601567;6197.473214776614;6246.968765156145;4937.716193789713;5940.673262970578;6055.818325450244;6103.298046209379;6131.927227014103;5082.745862706924;6204.13142160089;6228.937710623017;6260.248770147611;6261.530385221035;6007.639541627516;6045.21412216409;6067.362926892612;6104.236970378703;6134.631922084689 03:42:26 INFO - PROCESS | 1666 | |1;ext.html;474.0566273116497;476.9308450274708;599.3526990849882;615.8121772859279;628.8868003759322;36119.73580924668;36727.71452999139;36812.07969800753;36963;36971.260574788525;33313.83401580945;33359.66640333596;33389;33540.82607108752;33601;8124.6750129994725;9284;9372.578233979453;9372.906270937305;9539;9335.813283734322;9490.620375184984;9525.047495250488;9596.376235544667;9668.274879384038;8606.440581362223;9580.56887440067;9601.663941762039;9634.759131021745;9674.177694895941;9471.289653276031;9550.9522452388;9578.233741300679;9650.951745241298;9671.951640241825;9445.952770236174;9527.52362381885;9586.76033099171;9625.71122866315;9633.22934165272;37089;37152.25695486102;37389;37457.43813842795;37520.62479375226;2841.559558268472;3120.7035331643456;3246.464333385012;3302.554155189043;3408.727301815849;26147.215583532525;26692.332691682863;26744.732552674417;26776.19671409861;27399;2776.694563598003;2781.958270625942;2818.2672505148603;2869.411770587025;2875.3386721054276;418295;418650;419348;421138;422778;43485.91285217831;58309.833803324545;58568.70715646395;58610.069496525;58656;38949.6105038946;42786.57213427888;43201;43249.56750432518;43487.565124348985;14922;15031.699366012837;15148.772768408482;15156.621084472976;15180.468683596022;11783.52865885355;11855.17013809025;12157.513699451923;12227;12240.755184896252;13815.447382104805;13913.399959004642;14062;14238.003339766325;14340.784888226684;6188.597741146811;6242.968785156045;6283;6289.40250676185;6306.463950564162;871.7254064969641;972.6741541583507;999.4453078541334;1058.9841152382721;1128.554221082684;28301.71698282991;28501.002464914043;28593.857030714713;28694.426111477653;28978;1070.7162601910345;1080.7514271717548;1087.5704096881686;1089.4334945828284;1101.2566517600587;11693.123015773852;13488.527901523596;13692.520761773489;13811.240381779098;13811.378487968066;521956;980339;1016634.9168254111;1021898;1026711.866440663;56775.71612141913;57112.42887571154;57558;57669.711651441474;58048.129278060864;1442.920639364845;1444.559409380128;1444.747169245399;1448.167303800298;1576.90538567684;28863.7113628861;29011.419771604873;29251.561226582045;29541;29724.702752972193;46777.53222467732;47335.76332118455;47395.28907066466;47601.523984761094;47985.760071199424;435182;466573.33426666656;501673;503666;505730.9426905684;26221.868890655423;27061.323466913484;31841.363172735953;31905.883294084597;32011;40033.599664004156;40729.59270407258;41413.58586414097;41682.166356673304;41769.58230417657;29685.85157074201;34872;34881.825590871886;35509.82245088758;35602.10994725153;34066.97799066032;34572.82713586416;34818.30363392668;35008.474872877436;35101;30722.846385767927;34267.65732342644;34315.4852677215;34334;34970.825145875126;23350.18274360389;27791;28623.42753144967;29393.265168370963;29502.262443439085;20083.497912552302;21615.783842161378;22065.33803985883;22705.091796328623;22726.886365568065 03:42:26 INFO - PROCESS | 1666 | |2;jquery.html;327.61341616892065;334.48656312560223;351.6465951718524;362.2266461105539;362.61562743491885;18676.346327878528;19027.238910443582;19595.412137635893;19806;19844.900775496102;14915.627109322273;15941.362345506195;18928.905355473238;19014.80985190148;19069.85580865149;5225.111731005729;5611.382747897728;5621.100623900177;5650.180723795047;5653.773849046054;4595.655325850558;5589.35722391924;5622.746976386073;5648.774049038034;5655.915161272585;5348.732563371836;5552.5280351169995;5586.497215250627;5622.128570071625;5664.858378540549;5452.291202143736;5477.315335583052;5512.3385193777;5533.031719449101;5686.2039314496005;5441.211024401439;5498.147787092967;5501.394846566875;5541.695206763627;5549.112142057252;12604.11771176018;12781.744365112645;21954.670679939813;23003;23041.769582304296;1894.8294653481253;1963.9509012274664;2003.5592169722638;2022;2395.6765836612008;9172.816543669156;9398.483083430408;9490.330408904121;9556;9669.274804389628;1547.806524184477;1650.6121061550525;1683.360323077235;1701.421516684321;1708.8291170882937;92022.53988730081;99184;103057.61956396837;108551;115027;8616.39685222041;9474.242060635133;10425.218108641882;10713.571457141783;10976.506057227443;13094.803577946339;13148.868511314955;13163.486199087227;13171.143875648053;13173.670658233621;7350.485466017328;7806.648700808477;8238.50568965852;8259.050209226016;8260.669573217005;8412.200840920103;8412.747617571482;8487;8495.40532162755;8509.276711479593;3397.3375191837354;3979.6617287530885;4005.799710014546;4311.719738217006;4340.587644173798;1854.110027186931;1889.0082706579155;1897.5445892985583;1932.5361913140746;1942.9319973801132;833.533221396008;838.773531146587;875.5447167473005;915.1946287267162;973.2846357926918;16130.274137663833;18217.45347639573;19250.422487325402;19492.31776887802;19548.218071277275;819.3854609043218;904.3759805734022;905.6415376934598;911.8176364727082;917.6788124156492;9596;10235.385876847413;10287;10380.027794718979;10389.272750907516;575891;578658;584924;595038;626416;117320.41339793247;118493.81506184828;121814.5637087271;122105;122106;905.6105874473908;1022.2792930983638;1027.4041056187393;1043.1446214104362;1046.9738256543494;13904.72190556163;17278.827211727723;17388.435040846383;17570.38503652366;17655.205515751564;39302.6069739299;47769.04461910673;49673.50326496689;49969.250461243835;51256.48743512517;65466.67266663636;65815.670921647;65988.67005664941;66619;67173;5924.822255332347;7557.319841214317;7656.4640475168435;7690.730824421342;7966.800829979297;9903.504824758877;12374.319412432402;12564.371781411075;12662.936685316514;13068.738625227632;10690.679279621623;10886.510107045044;10918.290311129751;11141.72145696364;11357.772844543228;11154.55381784752;11223.55105795759;11357.204995650225;11505.367204803817;11581.536738530365;11335.206535542433;11637.650870473899;11698.35659038761;11792.764144716886;11854.52581896749;7475.9159921812125;8022.358211342962;8050.194980502137;8056.1138274788555;8102.149274326347;10909.890901091205;11451.656450306504;11540.94229528847;11758.118141139277;11879.643610691694 03:42:26 INFO - PROCESS | 1666 | |3;mootools.html;1431.9570412887613;1559.267144442112;1777.3868015534636;1915.1477592471356;1935.138863205874;7581.052368453943;7824.530528168314;8572.314214862812;8753.474791512506;8776.561171941401;8504.78738031548;8515.872261916076;8633.223009929105;8636.524991125485;8655.43739656922;2029.2491778042145;2411.3248290478605;2411.8311718179734;2418.504206637635;2423.6849209602815;2391.414103544634;2431.6139800313827;2443.621238708003;2449.2652204338715;2449.510097980402;2176.553806469678;2369.92890213293;2423.987880060597;2437;2439.8048156147465;2443.0716327795503;2451.5464639041747;2457.1522824625476;2464.383904023994;2466.9753302467016;2421.5520128776234;2441.963370549443;2454.3005243505513;2461.101697880261;2463.8398504097177;8726.650933962634;8753.037165911745;8776.517291548962;8785.297176225886;8815.559222038937;5257.789688412459;5339.145736682151;5349.384820745625;5379.38137114233;5420.728963551806;3535.469679548088;3599.6040435552068;3621.5110960020324;3642.2715456908722;3691.1141326081815;1037.8101907608172;1070.4166229404993;1074.6883403812963;1076.1821016027798;1077.106002018323;11448.828267575993;11716.648500544998;11870.940645296805;11878.58424955131;11887.583934562335;4743;4771.761411929389;4832.1543729847135;4846.248831431134;4848.369711937426;9903.009699030039;9952.850707239397;9953.353032052893;9973.900260997298;10085.394876307446;4573.839915602938;5303.231031500411;5358.5981051421295;5428.321459817523;5429.619926605179;4406.911861762746;4769.594584460359;4865.854024379274;4901.215805471179;4952.603791696655;3807.5240594925635;3877.8836634901;3882.76703397797;3899.66852817508;3914.119323152325;1291.1671971578467;1306.6276111308232;1310.4430616987743;1321.9471221151239;1336.4988129451456;1021.2657831984769;1050.2963014779964;1070.8340207267886;1324.9933750331186;1334.099482849073;6613.272540020594;7980.720674776471;8026.719064832703;8116.797080072927;8122.878156827653;498.61357447977383;508.8117396563295;509.3226009407479;509.5083244668912;511.23059795009016;6055.1220073090035;6119.4798442132915;6160.845978850564;6163.537734669918;6167.6916154193;9890;10176.847347289797;10183.236257280734;10298.485075746183;10326.948365258126;9820.705378838646;10034.297599168134;10109.646162384428;10189.796204076025;10236.078752912274;7842.686292548234;7975.641096150687;7998.160193179749;8009.118996910335;8089.595520224083;6637.966810165918;7876.921230787619;7888.960555197187;7946.562939038177;7978.880316795136;9112.453252804853;9276.582553784961;9346.813063738551;9391.671291504765;9402.623895044122;9518.143367096718;9701.07839755222;9799.363041402286;9859.852102218329;9906.257030722869;7263.854722905618;7748.108967468813;7957.164497727887;8077.394195435483;8210.055843578066;7945.523268603671;7950.006249218848;8059.798505037421;8085.312748416451;8130.918690813016;6562.967185164234;6960.443164546926;7028.50800443964;7242.3843973262865;7343.8531229376185;7120.608366539683;7158.928410715826;7213.062301900719;7271;7298.270172982871;7320.524165929198;7468.253174682488;7507.62461876893;7559.584222867795;7570.129435115033;6837.521373503807;6847.383735463832;6905.1713794345;6907.654617269217;6931.2375638678695;6913.2049814272;6923.134608173978;7006.369426751617;7015.719371225094;7028.8594228114125 03:42:26 INFO - PROCESS | 1666 | |4;prototype.html;326.44341397916554;326.9493228549575;329.43008595130425;333.22192680091985;335.7783862650651;6969.790906272808;7063.717451301942;7068.575885446877;7117.78646640601;7136.500444968848;5649.49154576088;6876.587404755718;6898.448124150069;6902.482313826458;6991.930080699191;4853.441854186761;4972.254161875711;5044.873878153039;5086.237064440326;5112.693238405698;4141.420201171838;5164.277001219813;5171.5862730981435;5172.27588137661;5177.275181474596;4665.7200567965865;5079.111155547765;5087.465816089313;5103.362079740033;5108.897822043576;4090.5909409059004;5103.387593488768;5108.974455127719;5112.335396398463;5141.974290128563;4369.6722745794195;4369.978150109229;4372.3004319309075;4374.4531933508315;4391.6486681065435;5391.595630327702;6400.519961002943;6755.121834161577;6758.594484330907;6791.830204244884;5889.676067816268;5901.970490147564;5943;5952.345242023374;5966.850828729273;6989.685464154125;7438.442116841205;7445;7452.701891924316;7487.363574096208;4714.45783734868;4722.150012997659;4732.621390288768;4744.667873248874;4749.358836557055;6001.639901605918;7720.227977202235;7811.4922530035365;7850.371970242367;7867.055953285585;4562.5665561771575;4661.347411362412;4764.475907650156;4766.237402015661;4783.6412269079265;4829.275608658659;4843.733594652257;4848;4849.975750121297;4856.247281671346;5861.325947516005;5863.091220860773;5901.793437229677;5912.970435147797;5952.868954898642;7481.476296659291;7483.700651973969;7486.812829679302;7513.661885215179;7516.398688104939;1596.6008497875532;1644.2025617575466;1644.2683006062186;1671.2646435568554;1694.6017685843817;1062.9946850265699;1068.9358638481715;1081.9513121909533;1086.1690806533009;1095.3756358875364;6813.591184528944;6868.244493105754;6876.828079297958;6884.931150688529;6901.551399159039;6282.811515654537;7675.961620191863;7688.923110768821;7694.307512323918;7713.190115037953;5866.6186697864505;6617;6869.656517174221;6882.208546017172;6926.134233220848;3732.253549290153;4052.1895620875353;4066.7356621819486;4088;4089.7137200396282;7534.849303013909;7541.321281084729;7887;8013.559254240956;8049.436539442183;7918;7939.047314322318;7988.2810547049885;8042.356611471068;8093.635786389509;8117.107118216992;8120.878186827203;8122.675092996214;8141.307988821017;8145.959270203611;7517.398608111229;7789.922100778919;7800.765977020698;7819.491733037335;7829.217078292125;7626.694932202649;7633.6946522140715;7672.846543069219;7684.769456916301;7692.269234422721;8073.798155045936;8088.514689118671;8091.410748560639;8131.7560473185895;8146;4812.5668689818085;4822.42130944289;4828.227483602606;4828.66199366055;4836.322914792002;7522.661480233293;7772.883406749016;7844.333231675143;7881.408894333063;7890.368770498461;7470.962645186957;7498.475106742476;7527.360174385239;7529.811754705957;7552.282533159341;7476.214997425192;7500.249975002675;7505.474616776992;7513.924860751323;7534.171241163358;6047.365026672136;7049.612271325126;7240.271260300844;7307.3423391894985;7358.926410735824;6709.228438729413;6856.760013399507;7496.100467943882;7535.660895259617;7563.470557060953;5505.339359276913;7197.784066478014;7345.632718364167;7369;7382.852342953218 03:42:26 INFO - PROCESS | 1666 | |5;yui.html;684.7534887440523;689.5380095336125;709.2269426325305;735.4190189750097;739.9297066778657;14617.561473155809;14666.70666586669;14668.779968300483;14699;17046.062466564334;15464.304106315214;15962.201889905517;15981.920090399532;16000.279987400565;16018.919905400457;737.1780464781757;872.7556284240407;877.8858748362704;895.1093661806511;896.5248418338291;893.0043002052729;896.2426749396749;901.3960646366917;904.4528060523387;911.5260064766318;936.4287784451479;945.7021038372925;946.4652471353697;947.5735918836551;950.4629884115452;881.7266647339313;923.9445633261993;940.3934462271797;942.0155937045735;943.217129782279;687.4775170870124;691.1257259566652;696.4985210648325;699.6222040098392;699.832040310327;15115.773263401057;15185.392584296615;15187.012844165205;15213.695726085527;15215.923920380328;12302.876971230262;12340.13619046667;12343.691407714789;12479.438425270884;12541.435635396429;8039.95980020102;9847.409155450625;9923.354981926152;10232.53953572091;10273.691789246335;3464.8960531184107;3479.495473156378;3497.650234976482;3576.7853928764357;3597.2805438912324;81957.59021204915;84710;84788.88027799292;85286.5735671324;85378;9049.592768325441;9118.042605526456;9135.588898499584;9177.82026768643;9284.025177356416;20409.89795051045;20546.589068218553;20581.279655211994;20607.381778546667;20608.896955515127;7392.778216653509;7506.962465187639;7622.2758837910305;7623.237676232332;7710.306072453506;3882.320593896057;3886.96113038866;3901.141748815313;3965.864702808958;3967.147063381329;3385.4752513360468;3503.649635036527;3510.297940411928;3559.14580500678;3582.1044738815294;643.2184895352076;643.7553729582729;644.616453210339;647.5887811239802;662.3244290823333;536.9865753356197;571.3001573072952;602.3193791016124;616.6423474384846;616.8797084568556;8010.319122874621;8038.236367545074;8076.9192308077345;8204.958975205205;8280.544570048705;580.5732786401991;588.2911092133968;597.2295738497377;603.1525706382539;624.8000639795313;3260.510923361467;3765.8514153182996;3782.3569993100687;3793.4499497572697;3818.8472461101246;81297;83329;83559.16440835636;86707.69938450928;87667.12332876718;68504.6574767133;69731;71088.64455677792;76186;76532;62892.371076289564;64702.70594588082;66365.66817165884;67510.31224219335;68857.31142688509;6481.578697384655;8339.19722126579;8343.582820858812;8396.160383961555;8500.14998500145;38073.619263807006;38922.80538597289;41617.75146745602;45833;47916.520834791205;58693.70653146707;60127;64423.71152577016;65265;68612.656936715;10714.055376128123;10783.838242426213;10878.673639790819;10948.34309941406;11063.059639930696;11696.415179240834;11713.88286117128;11799;11946.820797688215;12019.81970270464;10926.836097458385;11188.888111118784;11302.208845381074;11578.884211157781;11920.284782912706;10591.594539127282;11150.665480035288;11211.271267367594;11437.485313161094;12017.339046352534;8803.60383782744;10668.83996740034;10684.679459616224;10905.945470272914;11654.825177622173;9121.726348209564;9180.724578262663;9502.904970950201;9534.52327383642;9755.609775608897;8833.823323533621;8902.287816974756;9261.259099272176;9432.85850712226;9472.242220622471 03:42:26 INFO - PROCESS | 1666 | __end_tp_report 03:42:26 INFO - PROCESS | 1666 | __start_cc_report 03:42:26 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,345 03:42:26 INFO - PROCESS | 1666 | __end_cc_report 03:42:26 INFO - PROCESS | 1666 | __startTimestamp1457005346241__endTimestamp 03:42:26 INFO - PROCESS | 1666 | 03:42:26 INFO - PROCESS | 1666 | ------- Summary: start ------- 03:42:26 INFO - PROCESS | 1666 | Number of tests: 6 03:42:26 INFO - PROCESS | 1666 | 03:42:26 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5759.16 Median:5987.91 stddev:737.07 (12.3%) stddev-sans-first:717.23 03:42:26 INFO - PROCESS | 1666 | Values: 3475.1 3594.0 3616.7 3645.2 3662.2 5865.1 5878.4 5906.7 5915.5 5934.7 4961.2 5768.6 5852.2 5949.9 5951.6 5291.2 5354.2 5385.1 5400.0 5422.6 580.2 5309.2 5356.0 5364.5 5423.9 5318.4 5320.0 5364.0 5372.8 5381.0 5264.3 5367.5 5397.8 5411.9 5414.6 5250.8 5277.4 5337.8 5353.4 5391.5 5221.7 5339.1 5723.8 5731.1 5799.7 6170.7 6236.0 6293.1 6319.8 6338.3 5623.8 6226.1 6279.8 6298.4 6306.0 5708.3 5987.6 5987.9 5992.1 5995.7 6221.4 6291.4 6301.9 6309.1 6314.3 6206.5 6266.3 6298.5 6311.4 6324.0 5291.8 6259.3 6270.9 6283.5 6314.5 5277.6 5656.5 6078.3 6215.1 6286.6 5173.9 6198.1 6236.0 6247.7 6285.0 4970.2 4981.6 4985.1 5009.3 5044.0 4473.7 4488.4 4496.9 4526.1 4579.7 5797.3 5873.3 5892.2 5895.9 5897.8 6227.3 6252.2 6271.7 6288.9 6294.0 5753.6 5832.7 5893.9 5904.4 5963.5 5446.8 5460.9 5482.3 5486.7 5487.5 6234.3 6390.1 6390.9 6397.2 6407.9 6221.4 6250.9 6278.7 6294.2 6307.8 6334.2 6338.5 6361.3 6366.9 6371.4 6114.1 6229.2 6295.4 6295.7 6313.6 5237.6 6212.3 6273.7 6304.5 6308.4 5756.8 6241.8 6247.3 6265.9 6285.8 6096.6 6122.2 6160.1 6197.5 6247.0 4937.7 5940.7 6055.8 6103.3 6131.9 5082.7 6204.1 6228.9 6260.2 6261.5 6007.6 6045.2 6067.4 6104.2 6134.6 03:42:26 INFO - PROCESS | 1666 | 03:42:26 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:70892.82 Median:34989.65 stddev:177471.67 (507.2%) stddev-sans-first:177890.77 03:42:26 INFO - PROCESS | 1666 | Values: 474.1 476.9 599.4 615.8 628.9 36119.7 36727.7 36812.1 36963.0 36971.3 33313.8 33359.7 33389.0 33540.8 33601.0 8124.7 9284.0 9372.6 9372.9 9539.0 9335.8 9490.6 9525.0 9596.4 9668.3 8606.4 9580.6 9601.7 9634.8 9674.2 9471.3 9551.0 9578.2 9651.0 9672.0 9446.0 9527.5 9586.8 9625.7 9633.2 37089.0 37152.3 37389.0 37457.4 37520.6 2841.6 3120.7 3246.5 3302.6 3408.7 26147.2 26692.3 26744.7 26776.2 27399.0 2776.7 2782.0 2818.3 2869.4 2875.3 418295.0 418650.0 419348.0 421138.0 422778.0 43485.9 58309.8 58568.7 58610.1 58656.0 38949.6 42786.6 43201.0 43249.6 43487.6 14922.0 15031.7 15148.8 15156.6 15180.5 11783.5 11855.2 12157.5 12227.0 12240.8 13815.4 13913.4 14062.0 14238.0 14340.8 6188.6 6243.0 6283.0 6289.4 6306.5 871.7 972.7 999.4 1059.0 1128.6 28301.7 28501.0 28593.9 28694.4 28978.0 1070.7 1080.8 1087.6 1089.4 1101.3 11693.1 13488.5 13692.5 13811.2 13811.4 521956.0 980339.0 1016634.9 1021898.0 1026711.9 56775.7 57112.4 57558.0 57669.7 58048.1 1442.9 1444.6 1444.7 1448.2 1576.9 28863.7 29011.4 29251.6 29541.0 29724.7 46777.5 47335.8 47395.3 47601.5 47985.8 435182.0 466573.3 501673.0 503666.0 505730.9 26221.9 27061.3 31841.4 31905.9 32011.0 40033.6 40729.6 41413.6 41682.2 41769.6 29685.9 34872.0 34881.8 35509.8 35602.1 34067.0 34572.8 34818.3 35008.5 35101.0 30722.8 34267.7 34315.5 34334.0 34970.8 23350.2 27791.0 28623.4 29393.3 29502.3 20083.5 21615.8 22065.3 22705.1 22726.9 03:42:26 INFO - PROCESS | 1666 | 03:42:26 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:33150.26 Median:1874.49 stddev:98404.23 (5249.6%) stddev-sans-first:98649.42 03:42:26 INFO - PROCESS | 1666 | Values: 327.6 334.5 351.6 362.2 362.6 18676.3 19027.2 19595.4 19806.0 19844.9 14915.6 15941.4 18928.9 19014.8 19069.9 5225.1 5611.4 5621.1 5650.2 5653.8 4595.7 5589.4 5622.7 5648.8 5655.9 5348.7 5552.5 5586.5 5622.1 5664.9 5452.3 5477.3 5512.3 5533.0 5686.2 5441.2 5498.1 5501.4 5541.7 5549.1 12604.1 12781.7 21954.7 23003.0 23041.8 1894.8 1964.0 2003.6 2022.0 2395.7 9172.8 9398.5 9490.3 9556.0 9669.3 1547.8 1650.6 1683.4 1701.4 1708.8 92022.5 99184.0 103057.6 108551.0 115027.0 8616.4 9474.2 10425.2 10713.6 10976.5 13094.8 13148.9 13163.5 13171.1 13173.7 7350.5 7806.6 8238.5 8259.1 8260.7 8412.2 8412.7 8487.0 8495.4 8509.3 3397.3 3979.7 4005.8 4311.7 4340.6 1854.1 1889.0 1897.5 1932.5 1942.9 833.5 838.8 875.5 915.2 973.3 16130.3 18217.5 19250.4 19492.3 19548.2 819.4 904.4 905.6 911.8 917.7 9596.0 10235.4 10287.0 10380.0 10389.3 575891.0 578658.0 584924.0 595038.0 626416.0 117320.4 118493.8 121814.6 122105.0 122106.0 905.6 1022.3 1027.4 1043.1 1047.0 13904.7 17278.8 17388.4 17570.4 17655.2 39302.6 47769.0 49673.5 49969.3 51256.5 65466.7 65815.7 65988.7 66619.0 67173.0 5924.8 7557.3 7656.5 7690.7 7966.8 9903.5 12374.3 12564.4 12662.9 13068.7 10690.7 10886.5 10918.3 11141.7 11357.8 11154.6 11223.6 11357.2 11505.4 11581.5 11335.2 11637.7 11698.4 11792.8 11854.5 7475.9 8022.4 8050.2 8056.1 8102.1 10909.9 11451.7 11540.9 11758.1 11879.6 03:42:26 INFO - PROCESS | 1666 | 03:42:26 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5922.49 Median:5400.06 stddev:3125.19 (57.9%) stddev-sans-first:3115.73 03:42:26 INFO - PROCESS | 1666 | Values: 1432.0 1559.3 1777.4 1915.1 1935.1 7581.1 7824.5 8572.3 8753.5 8776.6 8504.8 8515.9 8633.2 8636.5 8655.4 2029.2 2411.3 2411.8 2418.5 2423.7 2391.4 2431.6 2443.6 2449.3 2449.5 2176.6 2369.9 2424.0 2437.0 2439.8 2443.1 2451.5 2457.2 2464.4 2467.0 2421.6 2442.0 2454.3 2461.1 2463.8 8726.7 8753.0 8776.5 8785.3 8815.6 5257.8 5339.1 5349.4 5379.4 5420.7 3535.5 3599.6 3621.5 3642.3 3691.1 1037.8 1070.4 1074.7 1076.2 1077.1 11448.8 11716.6 11870.9 11878.6 11887.6 4743.0 4771.8 4832.2 4846.2 4848.4 9903.0 9952.9 9953.4 9973.9 10085.4 4573.8 5303.2 5358.6 5428.3 5429.6 4406.9 4769.6 4865.9 4901.2 4952.6 3807.5 3877.9 3882.8 3899.7 3914.1 1291.2 1306.6 1310.4 1321.9 1336.5 1021.3 1050.3 1070.8 1325.0 1334.1 6613.3 7980.7 8026.7 8116.8 8122.9 498.6 508.8 509.3 509.5 511.2 6055.1 6119.5 6160.8 6163.5 6167.7 9890.0 10176.8 10183.2 10298.5 10326.9 9820.7 10034.3 10109.6 10189.8 10236.1 7842.7 7975.6 7998.2 8009.1 8089.6 6638.0 7876.9 7889.0 7946.6 7978.9 9112.5 9276.6 9346.8 9391.7 9402.6 9518.1 9701.1 9799.4 9859.9 9906.3 7263.9 7748.1 7957.2 8077.4 8210.1 7945.5 7950.0 8059.8 8085.3 8130.9 6563.0 6960.4 7028.5 7242.4 7343.9 7120.6 7158.9 7213.1 7271.0 7298.3 7320.5 7468.3 7507.6 7559.6 7570.1 6837.5 6847.4 6905.2 6907.7 6931.2 6913.2 6923.1 7006.4 7015.7 7028.9 03:42:26 INFO - PROCESS | 1666 | 03:42:26 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:6030.71 Median:6868.95 stddev:1973.33 (28.7%) stddev-sans-first:1931.86 03:42:26 INFO - PROCESS | 1666 | Values: 326.4 326.9 329.4 333.2 335.8 6969.8 7063.7 7068.6 7117.8 7136.5 5649.5 6876.6 6898.4 6902.5 6991.9 4853.4 4972.3 5044.9 5086.2 5112.7 4141.4 5164.3 5171.6 5172.3 5177.3 4665.7 5079.1 5087.5 5103.4 5108.9 4090.6 5103.4 5109.0 5112.3 5142.0 4369.7 4370.0 4372.3 4374.5 4391.6 5391.6 6400.5 6755.1 6758.6 6791.8 5889.7 5902.0 5943.0 5952.3 5966.9 6989.7 7438.4 7445.0 7452.7 7487.4 4714.5 4722.2 4732.6 4744.7 4749.4 6001.6 7720.2 7811.5 7850.4 7867.1 4562.6 4661.3 4764.5 4766.2 4783.6 4829.3 4843.7 4848.0 4850.0 4856.2 5861.3 5863.1 5901.8 5913.0 5952.9 7481.5 7483.7 7486.8 7513.7 7516.4 1596.6 1644.2 1644.3 1671.3 1694.6 1063.0 1068.9 1082.0 1086.2 1095.4 6813.6 6868.2 6876.8 6884.9 6901.6 6282.8 7676.0 7688.9 7694.3 7713.2 5866.6 6617.0 6869.7 6882.2 6926.1 3732.3 4052.2 4066.7 4088.0 4089.7 7534.8 7541.3 7887.0 8013.6 8049.4 7918.0 7939.0 7988.3 8042.4 8093.6 8117.1 8120.9 8122.7 8141.3 8146.0 7517.4 7789.9 7800.8 7819.5 7829.2 7626.7 7633.7 7672.8 7684.8 7692.3 8073.8 8088.5 8091.4 8131.8 8146.0 4812.6 4822.4 4828.2 4828.7 4836.3 7522.7 7772.9 7844.3 7881.4 7890.4 7471.0 7498.5 7527.4 7529.8 7552.3 7476.2 7500.2 7505.5 7513.9 7534.2 6047.4 7049.6 7240.3 7307.3 7358.9 6709.2 6856.8 7496.1 7535.7 7563.5 5505.3 7197.8 7345.6 7369.0 7382.9 03:42:26 INFO - PROCESS | 1666 | 03:42:26 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:17528.31 Median:644.19 stddev:24339.62 (3778.4%) stddev-sans-first:24375.04 03:42:26 INFO - PROCESS | 1666 | Values: 684.8 689.5 709.2 735.4 739.9 14617.6 14666.7 14668.8 14699.0 17046.1 15464.3 15962.2 15981.9 16000.3 16018.9 737.2 872.8 877.9 895.1 896.5 893.0 896.2 901.4 904.5 911.5 936.4 945.7 946.5 947.6 950.5 881.7 923.9 940.4 942.0 943.2 687.5 691.1 696.5 699.6 699.8 15115.8 15185.4 15187.0 15213.7 15215.9 12302.9 12340.1 12343.7 12479.4 12541.4 8040.0 9847.4 9923.4 10232.5 10273.7 3464.9 3479.5 3497.7 3576.8 3597.3 81957.6 84710.0 84788.9 85286.6 85378.0 9049.6 9118.0 9135.6 9177.8 9284.0 20409.9 20546.6 20581.3 20607.4 20608.9 7392.8 7507.0 7622.3 7623.2 7710.3 3882.3 3887.0 3901.1 3965.9 3967.1 3385.5 3503.6 3510.3 3559.1 3582.1 643.2 643.8 644.6 647.6 662.3 537.0 571.3 602.3 616.6 616.9 8010.3 8038.2 8076.9 8205.0 8280.5 580.6 588.3 597.2 603.2 624.8 3260.5 3765.9 3782.4 3793.4 3818.8 81297.0 83329.0 83559.2 86707.7 87667.1 68504.7 69731.0 71088.6 76186.0 76532.0 62892.4 64702.7 66365.7 67510.3 68857.3 6481.6 8339.2 8343.6 8396.2 8500.1 38073.6 38922.8 41617.8 45833.0 47916.5 58693.7 60127.0 64423.7 65265.0 68612.7 10714.1 10783.8 10878.7 10948.3 11063.1 11696.4 11713.9 11799.0 11946.8 12019.8 10926.8 11188.9 11302.2 11578.9 11920.3 10591.6 11150.7 11211.3 11437.5 12017.3 8803.6 10668.8 10684.7 10905.9 11654.8 9121.7 9180.7 9502.9 9534.5 9755.6 8833.8 8902.3 9261.3 9432.9 9472.2 03:42:26 INFO - PROCESS | 1666 | -------- Summary: end -------- 03:42:26 INFO - PROCESS | 1666 | 03:42:26 INFO - TEST-INFO | 1666: exit 0 03:42:26 INFO - TEST-OK | dromaeo_css | took 1110619ms 03:42:26 INFO - TEST-START | kraken 03:42:26 INFO - operating with platform_type : mac_ 03:42:26 INFO - Initialising browser for kraken test... 03:42:26 INFO - TEST-INFO | started process 1702 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpxykzZ3/profile http://localhost:49275/getInfo.html) 03:42:29 INFO - PROCESS | 1702 | __metrics Screen width/height:1600/1200 03:42:29 INFO - PROCESS | 1702 | colorDepth:24 03:42:29 INFO - PROCESS | 1702 | Browser inner width/height: 1024/689 03:42:29 INFO - PROCESS | 1702 | __metrics 03:42:29 ERROR - PROCESS | 1702 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:42:30 INFO - TEST-INFO | 1702: exit 0 03:42:30 INFO - Browser initialized. 03:42:30 INFO - Running cycle 1/1 for kraken test... 03:42:30 INFO - TEST-INFO | started process 1705 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpxykzZ3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:41 INFO - PROCESS | 1705 | RSS: Main: 253947904 03:42:41 INFO - PROCESS | 1705 | 03:42:44 INFO - PROCESS | 1705 | 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) 03:42:45 INFO - PROCESS | 1705 | RSS: Main: 268230656 03:42:45 INFO - PROCESS | 1705 | 03:42:47 INFO - PROCESS | 1705 | 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) 03:42:48 INFO - PROCESS | 1705 | RSS: Main: 276770816 03:42:48 INFO - PROCESS | 1705 | 03:42:51 INFO - PROCESS | 1705 | 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) 03:42:52 INFO - PROCESS | 1705 | RSS: Main: 281128960 03:42:52 INFO - PROCESS | 1705 | 03:42:54 INFO - PROCESS | 1705 | 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) 03:42:54 INFO - PROCESS | 1705 | RSS: Main: 280383488 03:42:54 INFO - PROCESS | 1705 | 03:42:56 INFO - PROCESS | 1705 | 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) 03:42:57 INFO - PROCESS | 1705 | RSS: Main: 284086272 03:42:57 INFO - PROCESS | 1705 | 03:43:00 INFO - PROCESS | 1705 | 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) 03:43:00 INFO - PROCESS | 1705 | RSS: Main: 283860992 03:43:00 INFO - PROCESS | 1705 | 03:43:03 INFO - PROCESS | 1705 | 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) 03:43:04 INFO - PROCESS | 1705 | RSS: Main: 283443200 03:43:04 INFO - PROCESS | 1705 | 03:43:07 INFO - PROCESS | 1705 | 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) 03:43:07 INFO - PROCESS | 1705 | RSS: Main: 283738112 03:43:07 INFO - PROCESS | 1705 | 03:43:09 INFO - PROCESS | 1705 | 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) 03:43:10 INFO - PROCESS | 1705 | RSS: Main: 282099712 03:43:10 INFO - PROCESS | 1705 | 03:43:12 INFO - PROCESS | 1705 | 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) 03:43:12 INFO - PROCESS | 1705 | RSS: Main: 282488832 03:43:12 INFO - PROCESS | 1705 | 03:43:14 INFO - PROCESS | 1705 | 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) 03:43:15 INFO - PROCESS | 1705 | RSS: Main: 282894336 03:43:15 INFO - PROCESS | 1705 | 03:43:17 INFO - PROCESS | 1705 | 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) 03:43:18 INFO - PROCESS | 1705 | RSS: Main: 282189824 03:43:18 INFO - PROCESS | 1705 | 03:43:21 INFO - PROCESS | 1705 | 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) 03:43:21 INFO - PROCESS | 1705 | RSS: Main: 284356608 03:43:21 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | 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) 03:43:23 INFO - PROCESS | 1705 | RSS: Main: 284418048 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | __start_tp_report 03:43:23 INFO - PROCESS | 1705 | _x_x_mozilla_page_load 03:43:23 INFO - PROCESS | 1705 | _x_x_mozilla_page_load_details 03:43:23 INFO - PROCESS | 1705 | |i|pagename|runs| 03:43:23 INFO - PROCESS | 1705 | |0;ai-astar;118;108;116;116;115;126;115;118;115;115 03:43:23 INFO - PROCESS | 1705 | |1;audio-beat-detection;154;123;146;182;151;133;140;119;171;123 03:43:23 INFO - PROCESS | 1705 | |2;audio-dft;194;195;197;198;204;220;194;197;201;193 03:43:23 INFO - PROCESS | 1705 | |3;audio-fft;70;72;71;106;56;56;59;58;118;57 03:43:23 INFO - PROCESS | 1705 | |4;audio-oscillator;85;82;120;79;83;82;118;79;78;155 03:43:23 INFO - PROCESS | 1705 | |5;imaging-gaussian-blur;132;88;88;85;90;88;88;87;134;85 03:43:23 INFO - PROCESS | 1705 | |6;imaging-darkroom;99;94;94;94;124;94;94;100;152;125 03:43:23 INFO - PROCESS | 1705 | |7;imaging-desaturate;92;96;90;91;92;91;111;95;91;98 03:43:23 INFO - PROCESS | 1705 | |8;json-parse-financial;56;58;58;73;84;47;48;86;92;83 03:43:23 INFO - PROCESS | 1705 | |9;json-stringify-tinderbox;66;65;70;71;79;66;73;98;98;94 03:43:23 INFO - PROCESS | 1705 | |10;stanford-crypto-aes;86;84;87;84;84;87;86;84;86;88 03:43:23 INFO - PROCESS | 1705 | |11;stanford-crypto-ccm;122;126;140;133;135;129;137;135;141;137 03:43:23 INFO - PROCESS | 1705 | |12;stanford-crypto-pbkdf2;138;139;168;137;140;142;143;139;140;169 03:43:23 INFO - PROCESS | 1705 | |13;stanford-crypto-sha256-iterative;64;67;68;68;68;69;66;72;67;69 03:43:23 INFO - PROCESS | 1705 | __end_tp_report 03:43:23 INFO - PROCESS | 1705 | __start_cc_report 03:43:23 INFO - PROCESS | 1705 | _x_x_mozilla_cycle_collect,896 03:43:23 INFO - PROCESS | 1705 | __end_cc_report 03:43:23 INFO - PROCESS | 1705 | __startTimestamp1457005403652__endTimestamp 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | ------- Summary: start ------- 03:43:23 INFO - PROCESS | 1705 | Number of tests: 14 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | [#0] ai-astar Cycles:10 Average:116.20 Median:116.00 stddev:4.42 (3.8%) stddev-sans-first:4.64 03:43:23 INFO - PROCESS | 1705 | Values: 118.0 108.0 116.0 116.0 115.0 126.0 115.0 118.0 115.0 115.0 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:148.50 stddev:21.00 (14.1%) stddev-sans-first:21.97 03:43:23 INFO - PROCESS | 1705 | Values: 154.0 123.0 146.0 182.0 151.0 133.0 140.0 119.0 171.0 123.0 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | [#2] audio-dft Cycles:10 Average:199.30 Median:197.50 stddev:8.03 (4.1%) stddev-sans-first:8.28 03:43:23 INFO - PROCESS | 1705 | Values: 194.0 195.0 197.0 198.0 204.0 220.0 194.0 197.0 201.0 193.0 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | [#3] audio-fft Cycles:10 Average:72.30 Median:58.50 stddev:22.06 (37.7%) stddev-sans-first:23.38 03:43:23 INFO - PROCESS | 1705 | Values: 70.0 72.0 71.0 106.0 56.0 56.0 59.0 58.0 118.0 57.0 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:80.50 stddev:26.09 (32.4%) stddev-sans-first:27.36 03:43:23 INFO - PROCESS | 1705 | Values: 85.0 82.0 120.0 79.0 83.0 82.0 118.0 79.0 78.0 155.0 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | [#5] imaging-gaussian-blur Cycles:10 Average:96.50 Median:88.00 stddev:19.30 (21.9%) stddev-sans-first:15.62 03:43:23 INFO - PROCESS | 1705 | Values: 132.0 88.0 88.0 85.0 90.0 88.0 88.0 87.0 134.0 85.0 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | [#6] imaging-darkroom Cycles:10 Average:107.00 Median:94.00 stddev:19.99 (21.3%) stddev-sans-first:20.99 03:43:23 INFO - PROCESS | 1705 | Values: 99.0 94.0 94.0 94.0 124.0 94.0 94.0 100.0 152.0 125.0 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:92.00 stddev:6.29 (6.8%) stddev-sans-first:6.60 03:43:23 INFO - PROCESS | 1705 | Values: 92.0 96.0 90.0 91.0 92.0 91.0 111.0 95.0 91.0 98.0 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:78.00 stddev:16.96 (21.7%) stddev-sans-first:17.37 03:43:23 INFO - PROCESS | 1705 | Values: 56.0 58.0 58.0 73.0 84.0 47.0 48.0 86.0 92.0 83.0 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | [#9] json-stringify-tinderbox Cycles:10 Average:78.00 Median:76.00 stddev:13.55 (17.8%) stddev-sans-first:13.66 03:43:23 INFO - PROCESS | 1705 | Values: 66.0 65.0 70.0 71.0 79.0 66.0 73.0 98.0 98.0 94.0 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:1.51 (1.8%) stddev-sans-first:1.59 03:43:23 INFO - PROCESS | 1705 | Values: 86.0 84.0 87.0 84.0 84.0 87.0 86.0 84.0 86.0 88.0 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:136.00 stddev:6.11 (4.5%) stddev-sans-first:4.87 03:43:23 INFO - PROCESS | 1705 | Values: 122.0 126.0 140.0 133.0 135.0 129.0 137.0 135.0 141.0 137.0 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.50 Median:141.00 stddev:12.25 (8.7%) stddev-sans-first:12.69 03:43:23 INFO - PROCESS | 1705 | Values: 138.0 139.0 168.0 137.0 140.0 142.0 143.0 139.0 140.0 169.0 03:43:23 INFO - PROCESS | 1705 | 03:43:23 INFO - PROCESS | 1705 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:2.10 (3.1%) stddev-sans-first:1.72 03:43:23 INFO - PROCESS | 1705 | Values: 64.0 67.0 68.0 68.0 68.0 69.0 66.0 72.0 67.0 69.0 03:43:23 INFO - PROCESS | 1705 | -------- Summary: end -------- 03:43:23 INFO - PROCESS | 1705 | 03:43:24 INFO - TEST-INFO | 1705: exit 0 03:43:24 INFO - TEST-OK | kraken | took 57854ms 03:43:24 INFO - SUITE-END | took 1168s 03:43:24 INFO - Completed test suite (00:19:28) 03:43:24 INFO - Working with test: dromaeo_css 03:43:24 INFO - Generating results file: dromaeo_css 03:43:24 INFO - Working with test: kraken 03:43:24 INFO - Generating results file: kraken 03:43:24 INFO - javascript benchmark 03:43:24 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:43:24 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 03:43:24 INFO - process_Request line: dromaeo_css 7396.40 graph.html#tests=[[72,64,61]] 03:43:24 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:43:24 INFO - process_Request line: kraken 1505.20 graph.html#tests=[[232,64,61]] 03:43:24 INFO - RETURN: dromaeo_css: 7396.40 03:43:24 INFO - RETURN: kraken: 1505.20 03:43:24 INFO - javascript benchmark 03:43:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3475.1138459692775, 3593.9640603593957, 3616.6564176403267, 3645.1616128290493, 3662.212624285778, 5865.061590145578, 5878.441548052933, 5906.734196961136, 5915.497182739467, 5934.703264836762, 4961.18140506816, 5768.596198266123, 5852.239208902847, 5949.940500594993, 5951.58338916276, 5291.2327712481665, 5354.22363757255, 5385.057614917393, 5399.9730001349935, 5422.6475279106735, 580.2290052776149, 5309.230161626562, 5355.973220133894, 5364.544013758835, 5423.918641220384, 5318.441563635801, 5319.9734001330135, 5364.0, 5372.785088596452, 5381.0, 5264.341957255343, 5367.543758780508, 5397.8380648580605, 5411.864703382447, 5414.593905457106, 5250.789968401259, 5277.419483856773, 5337.759800808973, 5353.411124776271, 5391.541718953894, 5221.668474539007, 5339.119045357511, 5723.7996670116345, 5731.111677689964, 5799.681017544033, 6170.660613666291, 6235.968820155916, 6293.087502312139, 6319.778807741753, 6338.271098823649, 5623.831285061414, 6226.128342032074, 6279.780207692709, 6298.3701629837105, 6305.9910414333945, 5708.343540492855, 5987.580869339148, 5987.910181347327, 5992.13114098462, 5995.730192141321, 6221.377862213742, 6291.402316779899, 6301.936980630227, 6309.14826498426, 6314.305426403092, 6206.472449841724, 6266.310705822356, 6298.496120310364, 6311.400416960381, 6323.9683801580695, 5291.788328466895, 6259.342769009279, 6270.874582508324, 6283.465905398092, 6314.526410519229, 5277.627816767591, 5656.547476201894, 6078.331383547807, 6215.12988181655, 6286.622802631857, 5173.861750414902, 6198.101275315144, 6236.002239641635, 6247.718852651642, 6284.968575157186, 4970.2296144097, 4981.576565991932, 4985.052839960396, 5009.273655319958, 5043.974780126149, 4473.664475164375, 4488.39406680094, 4496.865094047183, 4526.117407105648, 4579.748113853703, 5797.333306669702, 5873.2658417697785, 5892.234009578728, 5895.941040589625, 5897.823065308047, 6227.252729672468, 6252.249730032425, 6271.686415679198, 6288.874222515524, 6293.96853015732, 5753.626014309057, 5832.708364581838, 5893.882122357614, 5904.380040095728, 5963.463288303987, 5446.809361672323, 5460.945390546123, 5482.2873026507095, 5486.725663716878, 5487.506124448819, 6234.314225435108, 6390.073439351361, 6390.8721825563225, 6397.232332120176, 6407.871842563122, 6221.4089661482085, 6250.937490625036, 6278.717457714322, 6294.15028971083, 6307.810765677037, 6334.1765570475545, 6338.492920566251, 6361.332060133619, 6366.936330636634, 6371.39471750183, 6114.144019837316, 6229.221347331583, 6295.433410993032, 6295.685215739286, 6313.621182729051, 5237.580993520585, 6212.347703491068, 6273.686315684289, 6304.495640348853, 6308.432241098323, 5756.769729210785, 6241.78153764616, 6247.2815626201755, 6265.937340626718, 6285.811425657238, 6096.6476373754385, 6122.204113465221, 6160.075988601567, 6197.473214776614, 6246.968765156145, 4937.716193789713, 5940.673262970578, 6055.818325450244, 6103.298046209379, 6131.927227014103, 5082.745862706924, 6204.13142160089, 6228.937710623017, 6260.248770147611, 6261.530385221035, 6007.639541627516, 6045.21412216409, 6067.362926892612, 6104.236970378703, 6134.631922084689], "unit": "score", "name": "dojo.html", "value": 5720.114571140272}, {"lowerIsBetter": false, "replicates": [474.0566273116497, 476.9308450274708, 599.3526990849882, 615.8121772859279, 628.8868003759322, 36119.73580924668, 36727.71452999139, 36812.07969800753, 36963.0, 36971.260574788525, 33313.83401580945, 33359.66640333596, 33389.0, 33540.82607108752, 33601.0, 8124.6750129994725, 9284.0, 9372.578233979453, 9372.906270937305, 9539.0, 9335.813283734322, 9490.620375184984, 9525.047495250488, 9596.376235544667, 9668.274879384038, 8606.440581362223, 9580.56887440067, 9601.663941762039, 9634.759131021745, 9674.177694895941, 9471.289653276031, 9550.9522452388, 9578.233741300679, 9650.951745241298, 9671.951640241825, 9445.952770236174, 9527.52362381885, 9586.76033099171, 9625.71122866315, 9633.22934165272, 37089.0, 37152.25695486102, 37389.0, 37457.43813842795, 37520.62479375226, 2841.559558268472, 3120.7035331643456, 3246.464333385012, 3302.554155189043, 3408.727301815849, 26147.215583532525, 26692.332691682863, 26744.732552674417, 26776.19671409861, 27399.0, 2776.694563598003, 2781.958270625942, 2818.2672505148603, 2869.411770587025, 2875.3386721054276, 418295.0, 418650.0, 419348.0, 421138.0, 422778.0, 43485.91285217831, 58309.833803324545, 58568.70715646395, 58610.069496525, 58656.0, 38949.6105038946, 42786.57213427888, 43201.0, 43249.56750432518, 43487.565124348985, 14922.0, 15031.699366012837, 15148.772768408482, 15156.621084472976, 15180.468683596022, 11783.52865885355, 11855.17013809025, 12157.513699451923, 12227.0, 12240.755184896252, 13815.447382104805, 13913.399959004642, 14062.0, 14238.003339766325, 14340.784888226684, 6188.597741146811, 6242.968785156045, 6283.0, 6289.40250676185, 6306.463950564162, 871.7254064969641, 972.6741541583507, 999.4453078541334, 1058.9841152382721, 1128.554221082684, 28301.71698282991, 28501.002464914043, 28593.857030714713, 28694.426111477653, 28978.0, 1070.7162601910345, 1080.7514271717548, 1087.5704096881686, 1089.4334945828284, 1101.2566517600587, 11693.123015773852, 13488.527901523596, 13692.520761773489, 13811.240381779098, 13811.378487968066, 521956.0, 980339.0, 1016634.9168254111, 1021898.0, 1026711.866440663, 56775.71612141913, 57112.42887571154, 57558.0, 57669.711651441474, 58048.129278060864, 1442.920639364845, 1444.559409380128, 1444.747169245399, 1448.167303800298, 1576.90538567684, 28863.7113628861, 29011.419771604873, 29251.561226582045, 29541.0, 29724.702752972193, 46777.53222467732, 47335.76332118455, 47395.28907066466, 47601.523984761094, 47985.760071199424, 435182.0, 466573.33426666656, 501673.0, 503666.0, 505730.9426905684, 26221.868890655423, 27061.323466913484, 31841.363172735953, 31905.883294084597, 32011.0, 40033.599664004156, 40729.59270407258, 41413.58586414097, 41682.166356673304, 41769.58230417657, 29685.85157074201, 34872.0, 34881.825590871886, 35509.82245088758, 35602.10994725153, 34066.97799066032, 34572.82713586416, 34818.30363392668, 35008.474872877436, 35101.0, 30722.846385767927, 34267.65732342644, 34315.4852677215, 34334.0, 34970.825145875126, 23350.18274360389, 27791.0, 28623.42753144967, 29393.265168370963, 29502.262443439085, 20083.497912552302, 21615.783842161378, 22065.33803985883, 22705.091796328623, 22726.886365568065], "unit": "score", "name": "ext.html", "value": 18563.327189660497}, {"lowerIsBetter": false, "replicates": [327.61341616892065, 334.48656312560223, 351.6465951718524, 362.2266461105539, 362.61562743491885, 18676.346327878528, 19027.238910443582, 19595.412137635893, 19806.0, 19844.900775496102, 14915.627109322273, 15941.362345506195, 18928.905355473238, 19014.80985190148, 19069.85580865149, 5225.111731005729, 5611.382747897728, 5621.100623900177, 5650.180723795047, 5653.773849046054, 4595.655325850558, 5589.35722391924, 5622.746976386073, 5648.774049038034, 5655.915161272585, 5348.732563371836, 5552.5280351169995, 5586.497215250627, 5622.128570071625, 5664.858378540549, 5452.291202143736, 5477.315335583052, 5512.3385193777, 5533.031719449101, 5686.2039314496005, 5441.211024401439, 5498.147787092967, 5501.394846566875, 5541.695206763627, 5549.112142057252, 12604.11771176018, 12781.744365112645, 21954.670679939813, 23003.0, 23041.769582304296, 1894.8294653481253, 1963.9509012274664, 2003.5592169722638, 2022.0, 2395.6765836612008, 9172.816543669156, 9398.483083430408, 9490.330408904121, 9556.0, 9669.274804389628, 1547.806524184477, 1650.6121061550525, 1683.360323077235, 1701.421516684321, 1708.8291170882937, 92022.53988730081, 99184.0, 103057.61956396837, 108551.0, 115027.0, 8616.39685222041, 9474.242060635133, 10425.218108641882, 10713.571457141783, 10976.506057227443, 13094.803577946339, 13148.868511314955, 13163.486199087227, 13171.143875648053, 13173.670658233621, 7350.485466017328, 7806.648700808477, 8238.50568965852, 8259.050209226016, 8260.669573217005, 8412.200840920103, 8412.747617571482, 8487.0, 8495.40532162755, 8509.276711479593, 3397.3375191837354, 3979.6617287530885, 4005.799710014546, 4311.719738217006, 4340.587644173798, 1854.110027186931, 1889.0082706579155, 1897.5445892985583, 1932.5361913140746, 1942.9319973801132, 833.533221396008, 838.773531146587, 875.5447167473005, 915.1946287267162, 973.2846357926918, 16130.274137663833, 18217.45347639573, 19250.422487325402, 19492.31776887802, 19548.218071277275, 819.3854609043218, 904.3759805734022, 905.6415376934598, 911.8176364727082, 917.6788124156492, 9596.0, 10235.385876847413, 10287.0, 10380.027794718979, 10389.272750907516, 575891.0, 578658.0, 584924.0, 595038.0, 626416.0, 117320.41339793247, 118493.81506184828, 121814.5637087271, 122105.0, 122106.0, 905.6105874473908, 1022.2792930983638, 1027.4041056187393, 1043.1446214104362, 1046.9738256543494, 13904.72190556163, 17278.827211727723, 17388.435040846383, 17570.38503652366, 17655.205515751564, 39302.6069739299, 47769.04461910673, 49673.50326496689, 49969.250461243835, 51256.48743512517, 65466.67266663636, 65815.670921647, 65988.67005664941, 66619.0, 67173.0, 5924.822255332347, 7557.319841214317, 7656.4640475168435, 7690.730824421342, 7966.800829979297, 9903.504824758877, 12374.319412432402, 12564.371781411075, 12662.936685316514, 13068.738625227632, 10690.679279621623, 10886.510107045044, 10918.290311129751, 11141.72145696364, 11357.772844543228, 11154.55381784752, 11223.55105795759, 11357.204995650225, 11505.367204803817, 11581.536738530365, 11335.206535542433, 11637.650870473899, 11698.35659038761, 11792.764144716886, 11854.52581896749, 7475.9159921812125, 8022.358211342962, 8050.194980502137, 8056.1138274788555, 8102.149274326347, 10909.890901091205, 11451.656450306504, 11540.94229528847, 11758.118141139277, 11879.643610691694], "unit": "score", "name": "jquery.html", "value": 8935.107744556204}, {"lowerIsBetter": false, "replicates": [1431.9570412887613, 1559.267144442112, 1777.3868015534636, 1915.1477592471356, 1935.138863205874, 7581.052368453943, 7824.530528168314, 8572.314214862812, 8753.474791512506, 8776.561171941401, 8504.78738031548, 8515.872261916076, 8633.223009929105, 8636.524991125485, 8655.43739656922, 2029.2491778042145, 2411.3248290478605, 2411.8311718179734, 2418.504206637635, 2423.6849209602815, 2391.414103544634, 2431.6139800313827, 2443.621238708003, 2449.2652204338715, 2449.510097980402, 2176.553806469678, 2369.92890213293, 2423.987880060597, 2437.0, 2439.8048156147465, 2443.0716327795503, 2451.5464639041747, 2457.1522824625476, 2464.383904023994, 2466.9753302467016, 2421.5520128776234, 2441.963370549443, 2454.3005243505513, 2461.101697880261, 2463.8398504097177, 8726.650933962634, 8753.037165911745, 8776.517291548962, 8785.297176225886, 8815.559222038937, 5257.789688412459, 5339.145736682151, 5349.384820745625, 5379.38137114233, 5420.728963551806, 3535.469679548088, 3599.6040435552068, 3621.5110960020324, 3642.2715456908722, 3691.1141326081815, 1037.8101907608172, 1070.4166229404993, 1074.6883403812963, 1076.1821016027798, 1077.106002018323, 11448.828267575993, 11716.648500544998, 11870.940645296805, 11878.58424955131, 11887.583934562335, 4743.0, 4771.761411929389, 4832.1543729847135, 4846.248831431134, 4848.369711937426, 9903.009699030039, 9952.850707239397, 9953.353032052893, 9973.900260997298, 10085.394876307446, 4573.839915602938, 5303.231031500411, 5358.5981051421295, 5428.321459817523, 5429.619926605179, 4406.911861762746, 4769.594584460359, 4865.854024379274, 4901.215805471179, 4952.603791696655, 3807.5240594925635, 3877.8836634901, 3882.76703397797, 3899.66852817508, 3914.119323152325, 1291.1671971578467, 1306.6276111308232, 1310.4430616987743, 1321.9471221151239, 1336.4988129451456, 1021.2657831984769, 1050.2963014779964, 1070.8340207267886, 1324.9933750331186, 1334.099482849073, 6613.272540020594, 7980.720674776471, 8026.719064832703, 8116.797080072927, 8122.878156827653, 498.61357447977383, 508.8117396563295, 509.3226009407479, 509.5083244668912, 511.23059795009016, 6055.1220073090035, 6119.4798442132915, 6160.845978850564, 6163.537734669918, 6167.6916154193, 9890.0, 10176.847347289797, 10183.236257280734, 10298.485075746183, 10326.948365258126, 9820.705378838646, 10034.297599168134, 10109.646162384428, 10189.796204076025, 10236.078752912274, 7842.686292548234, 7975.641096150687, 7998.160193179749, 8009.118996910335, 8089.595520224083, 6637.966810165918, 7876.921230787619, 7888.960555197187, 7946.562939038177, 7978.880316795136, 9112.453252804853, 9276.582553784961, 9346.813063738551, 9391.671291504765, 9402.623895044122, 9518.143367096718, 9701.07839755222, 9799.363041402286, 9859.852102218329, 9906.257030722869, 7263.854722905618, 7748.108967468813, 7957.164497727887, 8077.394195435483, 8210.055843578066, 7945.523268603671, 7950.006249218848, 8059.798505037421, 8085.312748416451, 8130.918690813016, 6562.967185164234, 6960.443164546926, 7028.50800443964, 7242.3843973262865, 7343.8531229376185, 7120.608366539683, 7158.928410715826, 7213.062301900719, 7271.0, 7298.270172982871, 7320.524165929198, 7468.253174682488, 7507.62461876893, 7559.584222867795, 7570.129435115033, 6837.521373503807, 6847.383735463832, 6905.1713794345, 6907.654617269217, 6931.2375638678695, 6913.2049814272, 6923.134608173978, 7006.369426751617, 7015.719371225094, 7028.8594228114125], "unit": "score", "name": "mootools.html", "value": 4755.124528965489}, {"lowerIsBetter": false, "replicates": [326.44341397916554, 326.9493228549575, 329.43008595130425, 333.22192680091985, 335.7783862650651, 6969.790906272808, 7063.717451301942, 7068.575885446877, 7117.78646640601, 7136.500444968848, 5649.49154576088, 6876.587404755718, 6898.448124150069, 6902.482313826458, 6991.930080699191, 4853.441854186761, 4972.254161875711, 5044.873878153039, 5086.237064440326, 5112.693238405698, 4141.420201171838, 5164.277001219813, 5171.5862730981435, 5172.27588137661, 5177.275181474596, 4665.7200567965865, 5079.111155547765, 5087.465816089313, 5103.362079740033, 5108.897822043576, 4090.5909409059004, 5103.387593488768, 5108.974455127719, 5112.335396398463, 5141.974290128563, 4369.6722745794195, 4369.978150109229, 4372.3004319309075, 4374.4531933508315, 4391.6486681065435, 5391.595630327702, 6400.519961002943, 6755.121834161577, 6758.594484330907, 6791.830204244884, 5889.676067816268, 5901.970490147564, 5943.0, 5952.345242023374, 5966.850828729273, 6989.685464154125, 7438.442116841205, 7445.0, 7452.701891924316, 7487.363574096208, 4714.45783734868, 4722.150012997659, 4732.621390288768, 4744.667873248874, 4749.358836557055, 6001.639901605918, 7720.227977202235, 7811.4922530035365, 7850.371970242367, 7867.055953285585, 4562.5665561771575, 4661.347411362412, 4764.475907650156, 4766.237402015661, 4783.6412269079265, 4829.275608658659, 4843.733594652257, 4848.0, 4849.975750121297, 4856.247281671346, 5861.325947516005, 5863.091220860773, 5901.793437229677, 5912.970435147797, 5952.868954898642, 7481.476296659291, 7483.700651973969, 7486.812829679302, 7513.661885215179, 7516.398688104939, 1596.6008497875532, 1644.2025617575466, 1644.2683006062186, 1671.2646435568554, 1694.6017685843817, 1062.9946850265699, 1068.9358638481715, 1081.9513121909533, 1086.1690806533009, 1095.3756358875364, 6813.591184528944, 6868.244493105754, 6876.828079297958, 6884.931150688529, 6901.551399159039, 6282.811515654537, 7675.961620191863, 7688.923110768821, 7694.307512323918, 7713.190115037953, 5866.6186697864505, 6617.0, 6869.656517174221, 6882.208546017172, 6926.134233220848, 3732.253549290153, 4052.1895620875353, 4066.7356621819486, 4088.0, 4089.7137200396282, 7534.849303013909, 7541.321281084729, 7887.0, 8013.559254240956, 8049.436539442183, 7918.0, 7939.047314322318, 7988.2810547049885, 8042.356611471068, 8093.635786389509, 8117.107118216992, 8120.878186827203, 8122.675092996214, 8141.307988821017, 8145.959270203611, 7517.398608111229, 7789.922100778919, 7800.765977020698, 7819.491733037335, 7829.217078292125, 7626.694932202649, 7633.6946522140715, 7672.846543069219, 7684.769456916301, 7692.269234422721, 8073.798155045936, 8088.514689118671, 8091.410748560639, 8131.7560473185895, 8146.0, 4812.5668689818085, 4822.42130944289, 4828.227483602606, 4828.66199366055, 4836.322914792002, 7522.661480233293, 7772.883406749016, 7844.333231675143, 7881.408894333063, 7890.368770498461, 7470.962645186957, 7498.475106742476, 7527.360174385239, 7529.811754705957, 7552.282533159341, 7476.214997425192, 7500.249975002675, 7505.474616776992, 7513.924860751323, 7534.171241163358, 6047.365026672136, 7049.612271325126, 7240.271260300844, 7307.3423391894985, 7358.926410735824, 6709.228438729413, 6856.760013399507, 7496.100467943882, 7535.660895259617, 7563.470557060953, 5505.339359276913, 7197.784066478014, 7345.632718364167, 7369.0, 7382.852342953218], "unit": "score", "name": "prototype.html", "value": 5364.492619717867}, {"lowerIsBetter": false, "replicates": [684.7534887440523, 689.5380095336125, 709.2269426325305, 735.4190189750097, 739.9297066778657, 14617.561473155809, 14666.70666586669, 14668.779968300483, 14699.0, 17046.062466564334, 15464.304106315214, 15962.201889905517, 15981.920090399532, 16000.279987400565, 16018.919905400457, 737.1780464781757, 872.7556284240407, 877.8858748362704, 895.1093661806511, 896.5248418338291, 893.0043002052729, 896.2426749396749, 901.3960646366917, 904.4528060523387, 911.5260064766318, 936.4287784451479, 945.7021038372925, 946.4652471353697, 947.5735918836551, 950.4629884115452, 881.7266647339313, 923.9445633261993, 940.3934462271797, 942.0155937045735, 943.217129782279, 687.4775170870124, 691.1257259566652, 696.4985210648325, 699.6222040098392, 699.832040310327, 15115.773263401057, 15185.392584296615, 15187.012844165205, 15213.695726085527, 15215.923920380328, 12302.876971230262, 12340.13619046667, 12343.691407714789, 12479.438425270884, 12541.435635396429, 8039.95980020102, 9847.409155450625, 9923.354981926152, 10232.53953572091, 10273.691789246335, 3464.8960531184107, 3479.495473156378, 3497.650234976482, 3576.7853928764357, 3597.2805438912324, 81957.59021204915, 84710.0, 84788.88027799292, 85286.5735671324, 85378.0, 9049.592768325441, 9118.042605526456, 9135.588898499584, 9177.82026768643, 9284.025177356416, 20409.89795051045, 20546.589068218553, 20581.279655211994, 20607.381778546667, 20608.896955515127, 7392.778216653509, 7506.962465187639, 7622.2758837910305, 7623.237676232332, 7710.306072453506, 3882.320593896057, 3886.96113038866, 3901.141748815313, 3965.864702808958, 3967.147063381329, 3385.4752513360468, 3503.649635036527, 3510.297940411928, 3559.14580500678, 3582.1044738815294, 643.2184895352076, 643.7553729582729, 644.616453210339, 647.5887811239802, 662.3244290823333, 536.9865753356197, 571.3001573072952, 602.3193791016124, 616.6423474384846, 616.8797084568556, 8010.319122874621, 8038.236367545074, 8076.9192308077345, 8204.958975205205, 8280.544570048705, 580.5732786401991, 588.2911092133968, 597.2295738497377, 603.1525706382539, 624.8000639795313, 3260.510923361467, 3765.8514153182996, 3782.3569993100687, 3793.4499497572697, 3818.8472461101246, 81297.0, 83329.0, 83559.16440835636, 86707.69938450928, 87667.12332876718, 68504.6574767133, 69731.0, 71088.64455677792, 76186.0, 76532.0, 62892.371076289564, 64702.70594588082, 66365.66817165884, 67510.31224219335, 68857.31142688509, 6481.578697384655, 8339.19722126579, 8343.582820858812, 8396.160383961555, 8500.14998500145, 38073.619263807006, 38922.80538597289, 41617.75146745602, 45833.0, 47916.520834791205, 58693.70653146707, 60127.0, 64423.71152577016, 65265.0, 68612.656936715, 10714.055376128123, 10783.838242426213, 10878.673639790819, 10948.34309941406, 11063.059639930696, 11696.415179240834, 11713.88286117128, 11799.0, 11946.820797688215, 12019.81970270464, 10926.836097458385, 11188.888111118784, 11302.208845381074, 11578.884211157781, 11920.284782912706, 10591.594539127282, 11150.665480035288, 11211.271267367594, 11437.485313161094, 12017.339046352534, 8803.60383782744, 10668.83996740034, 10684.679459616224, 10905.945470272914, 11654.825177622173, 9121.726348209564, 9180.724578262663, 9502.904970950201, 9534.52327383642, 9755.609775608897, 8833.823323533621, 8902.287816974756, 9261.259099272176, 9432.85850712226, 9472.242220622471], "unit": "score", "name": "yui.html", "value": 6764.564719803245}], "name": "dromaeo_css", "value": 7396.401447121944}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [118.0, 108.0, 116.0, 116.0, 115.0, 126.0, 115.0, 118.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.2}, {"lowerIsBetter": true, "replicates": [154.0, 123.0, 146.0, 182.0, 151.0, 133.0, 140.0, 119.0, 171.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [194.0, 195.0, 197.0, 198.0, 204.0, 220.0, 194.0, 197.0, 201.0, 193.0], "unit": "score", "name": "audio-dft", "value": 199.3}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 71.0, 106.0, 56.0, 56.0, 59.0, 58.0, 118.0, 57.0], "unit": "score", "name": "audio-fft", "value": 72.3}, {"lowerIsBetter": true, "replicates": [85.0, 82.0, 120.0, 79.0, 83.0, 82.0, 118.0, 79.0, 78.0, 155.0], "unit": "score", "name": "audio-oscillator", "value": 96.1}, {"lowerIsBetter": true, "replicates": [132.0, 88.0, 88.0, 85.0, 90.0, 88.0, 88.0, 87.0, 134.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.5}, {"lowerIsBetter": true, "replicates": [99.0, 94.0, 94.0, 94.0, 124.0, 94.0, 94.0, 100.0, 152.0, 125.0], "unit": "score", "name": "imaging-darkroom", "value": 107.0}, {"lowerIsBetter": true, "replicates": [92.0, 96.0, 90.0, 91.0, 92.0, 91.0, 111.0, 95.0, 91.0, 98.0], "unit": "score", "name": "imaging-desaturate", "value": 94.7}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 58.0, 73.0, 84.0, 47.0, 48.0, 86.0, 92.0, 83.0], "unit": "score", "name": "json-parse-financial", "value": 68.5}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 70.0, 71.0, 79.0, 66.0, 73.0, 98.0, 98.0, 94.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 78.0}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 87.0, 84.0, 84.0, 87.0, 86.0, 84.0, 86.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [122.0, 126.0, 140.0, 133.0, 135.0, 129.0, 137.0, 135.0, 141.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.5}, {"lowerIsBetter": true, "replicates": [138.0, 139.0, 168.0, 137.0, 140.0, 142.0, 143.0, 139.0, 140.0, 169.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.5}, {"lowerIsBetter": true, "replicates": [64.0, 67.0, 68.0, 68.0, 68.0, 69.0, 66.0, 72.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1505.2}]} 03:43:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1505.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7396.40"}}} 03:43:24 INFO - Return code: 0 03:43:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:43:25 ERROR - # TBPL SUCCESS # 03:43:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:43:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:43:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:43:25 INFO - 2016-03-03 03:43:25.044 screenresolution[1710:10808] starting screenresolution argv=screenresolution get 03:43:25 INFO - 2016-03-03 03:43:25.047 screenresolution[1710:10808] Display 0: 1600x1200x32@60 03:43:25 INFO - 2016-03-03 03:43:25.053 screenresolution[1711:10811] starting screenresolution argv=screenresolution list 03:43:25 INFO - Available Modes on Display 0 03:43:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:43:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:43:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:43:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:43:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:43:25 INFO - Intel Iris: 03:43:25 INFO - Chipset Model: Intel Iris 03:43:25 INFO - Type: GPU 03:43:25 INFO - Bus: Built-In 03:43:25 INFO - VRAM (Dynamic, Max): 1536 MB 03:43:25 INFO - Vendor: Intel (0x8086) 03:43:25 INFO - Device ID: 0x0a2e 03:43:25 INFO - Revision ID: 0x0009 03:43:25 INFO - Displays: 03:43:25 INFO - Display: 03:43:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:43:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:43:25 INFO - Display Serial Number: 1600x1200 60 03:43:25 INFO - Main Display: Yes 03:43:25 INFO - Mirror: Off 03:43:25 INFO - Online: Yes 03:43:25 INFO - Rotation: Supported 03:43:25 INFO - Return code: 0 03:43:25 INFO - Running post-action listener: _resource_record_post_action 03:43:25 INFO - Running post-run listener: _resource_record_post_run 03:43:26 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 39585280; Write bytes: 707314688; Read time: 447; Write time: 2275 03:43:26 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 401957376; Write bytes: 403585024; Read time: 29911; Write time: 813 03:43:26 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 37770752; Write bytes: 302881792; Read time: 415; Write time: 1461 03:43:26 INFO - Running post-run listener: _upload_blobber_files 03:43:26 INFO - Blob upload gear active. 03:43:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:43:26 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 03:43:26 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'] 03:43:26 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 03:43:26 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:43:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:43:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:27 INFO - (blobuploader) - INFO - Done attempting. 03:43:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:43:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:43:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:28 INFO - (blobuploader) - INFO - Done attempting. 03:43:28 INFO - (blobuploader) - INFO - Iteration through files over. 03:43:28 INFO - Return code: 0 03:43:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:43:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:43:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a914fdd5ecbe4a46cc9bcbe2a14fa2402455f758692c98a394c48b2340d8a7142795f6ef9d2d6e49a4302fe60e684aa1f050462da8f0368000b141b50c611fcc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6c900762ca603e9b13dfd559ba7a71b8741448bf13662dce554d780530bcf60efd81cf56914f58b2a1966a6c279839926710fb8996eaf75bab1302faecdc2b8"} 03:43:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:43:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:43:28 INFO - Contents: 03:43:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a914fdd5ecbe4a46cc9bcbe2a14fa2402455f758692c98a394c48b2340d8a7142795f6ef9d2d6e49a4302fe60e684aa1f050462da8f0368000b141b50c611fcc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6c900762ca603e9b13dfd559ba7a71b8741448bf13662dce554d780530bcf60efd81cf56914f58b2a1966a6c279839926710fb8996eaf75bab1302faecdc2b8"} 03:43:28 INFO - Running post-run listener: copy_logs_to_upload_dir 03:43:28 INFO - Copying logs to upload dir... 03:43:28 INFO - mkdir: /builds/slave/test/build/upload/logs 03:43:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.967324 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-03 03:43:28.812432) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 03:43:28.815506) ========= 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.TbKvobWd8A/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.oiLxRLFKZd/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a914fdd5ecbe4a46cc9bcbe2a14fa2402455f758692c98a394c48b2340d8a7142795f6ef9d2d6e49a4302fe60e684aa1f050462da8f0368000b141b50c611fcc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6c900762ca603e9b13dfd559ba7a71b8741448bf13662dce554d780530bcf60efd81cf56914f58b2a1966a6c279839926710fb8996eaf75bab1302faecdc2b8"} build_url:https://queue.taskcluster.net/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011157 build_url: 'https://queue.taskcluster.net/v1/task/GrPEukFMQxOsPUfOic7d4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a914fdd5ecbe4a46cc9bcbe2a14fa2402455f758692c98a394c48b2340d8a7142795f6ef9d2d6e49a4302fe60e684aa1f050462da8f0368000b141b50c611fcc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6c900762ca603e9b13dfd559ba7a71b8741448bf13662dce554d780530bcf60efd81cf56914f58b2a1966a6c279839926710fb8996eaf75bab1302faecdc2b8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 03:43:28.842181) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 03:43:28.842519) ========= 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.TbKvobWd8A/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.oiLxRLFKZd/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.005056 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 03:43:28.890839) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 03:43:28.891164) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 03:43:28.891548) ========= ========= Total master_lag: 8.37 =========