builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0059 starttime: 1456143659.2 results: success (0) buildid: 20160222032957 builduid: 911c9e8d9f16436299c66d5a74154a60 revision: dec30ce4ea4ce5ed23dc40f2a8af7337bce7bc70 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 04:20:59.205121) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 04:20:59.205552) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 04:20:59.205884) ========= 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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.005972 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 04:20:59.255027) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 04:20:59.255336) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 04:20:59.302739) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 04:20:59.303038) ========= 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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.005534 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 04:20:59.357800) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 04:20:59.358117) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 04:20:59.358499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 04:20:59.358807) ========= 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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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-02-22 04:20:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 35.6M=0s 2016-02-22 04:20:59 (35.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.545912 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 04:20:59.920430) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 04:20:59.920710) ========= 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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.020051 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 04:20:59.969661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 04:20:59.970013) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dec30ce4ea4ce5ed23dc40f2a8af7337bce7bc70 --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 dec30ce4ea4ce5ed23dc40f2a8af7337bce7bc70 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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-02-22 04:20:59,972 truncating revision to first 12 chars 2016-02-22 04:20:59,972 Setting DEBUG logging. 2016-02-22 04:20:59,972 attempt 1/10 2016-02-22 04:20:59,972 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dec30ce4ea4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 04:21:00,906 unpacking tar archive at: fx-team-dec30ce4ea4c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.180014 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 04:21:01.165821) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 04:21:01.166177) ========= echo dec30ce4ea4ce5ed23dc40f2a8af7337bce7bc70 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dec30ce4ea4ce5ed23dc40f2a8af7337bce7bc70'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 dec30ce4ea4ce5ed23dc40f2a8af7337bce7bc70 program finished with exit code 0 elapsedTime=0.005200 script_repo_revision: 'dec30ce4ea4ce5ed23dc40f2a8af7337bce7bc70' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 04:21:01.217206) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 04:21:01.217570) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 04:21:01.230831) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-02-22 04:21:01.231208) ========= /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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 04:21:01 INFO - MultiFileLogger online at 20160222 04:21:01 in /builds/slave/test 04:21:01 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 04:21:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:21:01 INFO - {'append_to_log': False, 04:21:01 INFO - 'base_work_dir': '/builds/slave/test', 04:21:01 INFO - 'blob_upload_branch': 'Fx-Team', 04:21:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:21:01 INFO - 'branch': 'Fx-Team', 04:21:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:21:01 INFO - 'config_files': ('talos/mac_config.py',), 04:21:01 INFO - 'default_actions': ('clobber', 04:21:01 INFO - 'read-buildbot-config', 04:21:01 INFO - 'download-and-extract', 04:21:01 INFO - 'populate-webroot', 04:21:01 INFO - 'create-virtualenv', 04:21:01 INFO - 'install', 04:21:01 INFO - 'run-tests'), 04:21:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:21:01 INFO - 'download_minidump_stackwalk': True, 04:21:01 INFO - 'download_symbols': 'ondemand', 04:21:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:21:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:21:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:21:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:21:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:21:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:21:01 INFO - 'installer_path': 'installer.exe', 04:21:01 INFO - 'log_level': 'info', 04:21:01 INFO - 'log_name': 'talos', 04:21:01 INFO - 'log_to_console': True, 04:21:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:21:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:21:01 INFO - 'opt_config_files': (), 04:21:01 INFO - 'pip_index': False, 04:21:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:21:01 INFO - 'cmd': ('bash', 04:21:01 INFO - '-c', 04:21:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:21:01 INFO - 'enabled': True, 04:21:01 INFO - 'halt_on_failure': False, 04:21:01 INFO - 'name': 'check_screen_resolution'},), 04:21:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:21:01 INFO - 'cmd': ('bash', 04:21:01 INFO - '-c', 04:21:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:21:01 INFO - 'enabled': True, 04:21:01 INFO - 'halt_on_failure': False, 04:21:01 INFO - 'name': 'check_screen_resolution'},), 04:21:01 INFO - 'run_cmd_checks_enabled': True, 04:21:01 INFO - 'sps_profile': False, 04:21:01 INFO - 'sps_profile_interval': 0, 04:21:01 INFO - 'suite': 'dromaeojs-e10s', 04:21:01 INFO - 'system_bits': '32', 04:21:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:21:01 INFO - 'title': 't-yosemite-r7-0059', 04:21:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:21:01 INFO - 'use_talos_json': True, 04:21:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:21:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:21:01 INFO - 'work_dir': 'build'} 04:21:01 INFO - ##### 04:21:01 INFO - ##### Running clobber step. 04:21:01 INFO - ##### 04:21:01 INFO - Running pre-action listener: _resource_record_pre_action 04:21:01 INFO - Running main action method: clobber 04:21:01 INFO - rmtree: /builds/slave/test/build 04:21:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:21:02 INFO - Running post-action listener: _resource_record_post_action 04:21:02 INFO - ##### 04:21:02 INFO - ##### Running read-buildbot-config step. 04:21:02 INFO - ##### 04:21:02 INFO - Running pre-action listener: _resource_record_pre_action 04:21:02 INFO - Running main action method: read_buildbot_config 04:21:02 INFO - Using buildbot properties: 04:21:02 INFO - { 04:21:02 INFO - "project": "", 04:21:02 INFO - "product": "firefox", 04:21:02 INFO - "script_repo_revision": "production", 04:21:02 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 04:21:02 INFO - "repository": "", 04:21:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 04:21:02 INFO - "buildid": "20160222032957", 04:21:02 INFO - "pgo_build": "False", 04:21:02 INFO - "basedir": "/builds/slave/test", 04:21:02 INFO - "buildnumber": 389, 04:21:02 INFO - "slavename": "t-yosemite-r7-0059", 04:21:02 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:21:02 INFO - "platform": "yosemite_r7", 04:21:02 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:21:02 INFO - "branch": "fx-team", 04:21:02 INFO - "repo_path": "integration/fx-team", 04:21:02 INFO - "revision": "dec30ce4ea4ce5ed23dc40f2a8af7337bce7bc70", 04:21:02 INFO - "stage_platform": "macosx64", 04:21:02 INFO - "builduid": "911c9e8d9f16436299c66d5a74154a60", 04:21:02 INFO - "slavebuilddir": "test" 04:21:02 INFO - } 04:21:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:21:02 INFO - Running post-action listener: _resource_record_post_action 04:21:02 INFO - ##### 04:21:02 INFO - ##### Running download-and-extract step. 04:21:02 INFO - ##### 04:21:02 INFO - Running pre-action listener: _resource_record_pre_action 04:21:02 INFO - Running main action method: download_and_extract 04:21:02 INFO - mkdir: /builds/slave/test/build/tests 04:21: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')]} 04:21:02 INFO - https://queue.taskcluster.net/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:21:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/test_packages.json 04:21:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/test_packages.json 04:21:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:21:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:21:08 INFO - Downloaded 1277 bytes. 04:21:08 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:21:08 INFO - Using the following test package requirements: 04:21:08 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:21:08 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:21:08 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:21:08 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:21:08 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:21:08 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:21:08 INFO - u'jsshell-mac.zip'], 04:21:08 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:21:08 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:21:08 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:21:08 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:21:08 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:21:08 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:21:08 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:21:08 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:21:08 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:21:08 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:21:08 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:21:08 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:21:08 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:21:08 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')]} 04:21:08 INFO - https://queue.taskcluster.net/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:21:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:21:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:21:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/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 04:21:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/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 04:21:09 INFO - Downloaded 17825394 bytes. 04:21:09 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'] 04:21:09 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 04:21:12 INFO - Return code: 0 04:21:12 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 04:21: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')]} 04:21:12 INFO - https://queue.taskcluster.net/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:21:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:21:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:21:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/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 04:21:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/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 04:21:18 INFO - Downloaded 17825394 bytes. 04:21:18 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'] 04:21:18 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 04:21:22 INFO - Return code: 0 04:21:22 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')]} 04:21:22 INFO - https://queue.taskcluster.net/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/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 04:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/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 04:21:23 INFO - Downloaded 10707015 bytes. 04:21:23 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'] 04:21:23 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 04:21:23 INFO - Return code: 0 04:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:23 INFO - https://queue.taskcluster.net/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/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 04:21:27 INFO - Downloaded 111265240 bytes. 04:21:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:21:27 INFO - mkdir: /builds/slave/test/properties 04:21:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:21:27 INFO - Writing to file /builds/slave/test/properties/build_url 04:21:27 INFO - Contents: 04:21:27 INFO - build_url:https://queue.taskcluster.net/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:21:28 INFO - Running post-action listener: _resource_record_post_action 04:21:28 INFO - Running post-action listener: set_extra_try_arguments 04:21:28 INFO - ##### 04:21:28 INFO - ##### Running populate-webroot step. 04:21:28 INFO - ##### 04:21:28 INFO - Running pre-action listener: _resource_record_pre_action 04:21:28 INFO - Running main action method: populate_webroot 04:21:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:21:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:21:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:21:28 INFO - '--tppagecycles', 04:21:28 INFO - '7'], 04:21:28 INFO - 'tests': ['tsvgm']}}, 04:21:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:21:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:21:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:21:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:21:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:21:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:21:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:28 INFO - 'talos_options': ['--e10s'], 04:21:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:28 INFO - 'tests': ['damp', 'tps']}, 04:21:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:28 INFO - 'talos_options': ['--e10s'], 04:21:28 INFO - 'tests': ['damp', 'tps']}, 04:21:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:21:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:21:28 INFO - 'other': {'tests': ['a11yr', 04:21:28 INFO - 'ts_paint', 04:21:28 INFO - 'tpaint', 04:21:28 INFO - 'sessionrestore', 04:21:28 INFO - 'sessionrestore_no_auto_restore']}, 04:21:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:21:28 INFO - 'tests': ['a11yr', 04:21:28 INFO - 'ts_paint', 04:21:28 INFO - 'tpaint', 04:21:28 INFO - 'sessionrestore', 04:21:28 INFO - 'sessionrestore_no_auto_restore']}, 04:21:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:21:28 INFO - 'tests': ['a11yr', 04:21:28 INFO - 'ts_paint', 04:21:28 INFO - 'tpaint', 04:21:28 INFO - 'sessionrestore', 04:21:28 INFO - 'sessionrestore_no_auto_restore']}, 04:21:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:21:28 INFO - 'tests': ['a11yr', 04:21:28 INFO - 'ts_paint', 04:21:28 INFO - 'tpaint', 04:21:28 INFO - 'sessionrestore', 04:21:28 INFO - 'sessionrestore_no_auto_restore']}, 04:21:28 INFO - 'other_l64': {'tests': ['a11yr', 04:21:28 INFO - 'ts_paint', 04:21:28 INFO - 'tpaint', 04:21:28 INFO - 'sessionrestore', 04:21:28 INFO - 'sessionrestore_no_auto_restore']}, 04:21:28 INFO - 'other_nol64': {'tests': ['a11yr', 04:21:28 INFO - 'ts_paint', 04:21:28 INFO - 'tpaint', 04:21:28 INFO - 'sessionrestore', 04:21:28 INFO - 'sessionrestore_no_auto_restore']}, 04:21:28 INFO - 'svgr': {'tests': ['tsvgx', 04:21:28 INFO - 'tsvgr_opacity', 04:21:28 INFO - 'tart', 04:21:28 INFO - 'tscrollx', 04:21:28 INFO - 'cart']}, 04:21:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:21:28 INFO - 'tests': ['tsvgx', 04:21:28 INFO - 'tsvgr_opacity', 04:21:28 INFO - 'tart', 04:21:28 INFO - 'tscrollx', 04:21:28 INFO - 'cart']}, 04:21:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:28 INFO - 'tests': ['tp5o']}, 04:21:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:28 INFO - 'talos_options': ['--e10s'], 04:21:28 INFO - 'tests': ['tp5o']}, 04:21:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:28 INFO - 'talos_options': ['--xperf_path', 04:21:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:28 INFO - 'tests': ['tp5n']}, 04:21:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:28 INFO - 'talos_options': ['--e10s', 04:21:28 INFO - '--xperf_path', 04:21:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:28 INFO - 'tests': ['tp5n']}}, 04:21:28 INFO - 'talos.zip': {'path': '', 04:21:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:21:28 INFO - Running post-action listener: _resource_record_post_action 04:21:28 INFO - ##### 04:21:28 INFO - ##### Running create-virtualenv step. 04:21:28 INFO - ##### 04:21:28 INFO - Running pre-action listener: _resource_record_pre_action 04:21:28 INFO - Running main action method: create_virtualenv 04:21:28 INFO - Creating virtualenv /builds/slave/test/build/venv 04:21:28 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 04:21:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:21:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:21:28 INFO - Using real prefix '/tools/python27' 04:21:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:21:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:21:32 INFO - Installing pip.................done. 04:21:32 INFO - Return code: 0 04:21:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:32 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 0x10dc5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8858d94cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03d30>, '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 0x10d927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafab20>, '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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 04:21:32 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 04:21:32 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 04:21:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kNd5Hi7Hh/Render', 04:21:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:32 INFO - 'HOME': '/Users/cltbld', 04:21:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:32 INFO - 'LOGNAME': 'cltbld', 04:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:32 INFO - 'MOZ_NO_REMOTE': '1', 04:21:32 INFO - 'NO_EM_RESTART': '1', 04:21:32 INFO - 'PAGER': '/bin/cat', 04:21:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:32 INFO - 'PWD': '/builds/slave/test', 04:21:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:32 INFO - 'SHELL': '/bin/bash', 04:21:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujFPYN20NN/Listeners', 04:21:32 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 04:21:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:32 INFO - 'USER': 'cltbld', 04:21:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:32 INFO - 'XPC_FLAGS': '0x0', 04:21:32 INFO - 'XPC_SERVICE_NAME': '0', 04:21:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:32 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 04:21:32 INFO - Cleaning up... 04:21:32 INFO - Return code: 0 04:21:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:32 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 0x10dc5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8858d94cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03d30>, '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 0x10d927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafab20>, '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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 04:21:32 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 04:21:32 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 04:21:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kNd5Hi7Hh/Render', 04:21:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:32 INFO - 'HOME': '/Users/cltbld', 04:21:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:32 INFO - 'LOGNAME': 'cltbld', 04:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:32 INFO - 'MOZ_NO_REMOTE': '1', 04:21:32 INFO - 'NO_EM_RESTART': '1', 04:21:32 INFO - 'PAGER': '/bin/cat', 04:21:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:32 INFO - 'PWD': '/builds/slave/test', 04:21:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:32 INFO - 'SHELL': '/bin/bash', 04:21:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujFPYN20NN/Listeners', 04:21:32 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 04:21:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:32 INFO - 'USER': 'cltbld', 04:21:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:32 INFO - 'XPC_FLAGS': '0x0', 04:21:32 INFO - 'XPC_SERVICE_NAME': '0', 04:21:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:32 INFO - Downloading/unpacking psutil>=0.7.1 04:21:32 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 04:21:32 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 04:21:32 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 04:21:32 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 04:21:32 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 04:21:32 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 04:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:21:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:35 INFO - Installing collected packages: psutil 04:21:35 INFO - Running setup.py install for psutil 04:21:35 INFO - building 'psutil._psutil_osx' extension 04:21:35 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 04:21:36 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 04:21:36 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 04:21:36 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 04:21:36 INFO - building 'psutil._psutil_posix' extension 04:21:36 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 04:21:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:21:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:21:36 INFO - ^ 04:21:36 INFO - 1 warning generated. 04:21:36 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 04:21:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:36 INFO - Successfully installed psutil 04:21:36 INFO - Cleaning up... 04:21:36 INFO - Return code: 0 04:21:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:36 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 0x10dc5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8858d94cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03d30>, '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 0x10d927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafab20>, '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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 04:21:36 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 04:21:36 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 04:21:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kNd5Hi7Hh/Render', 04:21:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:36 INFO - 'HOME': '/Users/cltbld', 04:21:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:36 INFO - 'LOGNAME': 'cltbld', 04:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:36 INFO - 'MOZ_NO_REMOTE': '1', 04:21:36 INFO - 'NO_EM_RESTART': '1', 04:21:36 INFO - 'PAGER': '/bin/cat', 04:21:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:36 INFO - 'PWD': '/builds/slave/test', 04:21:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:36 INFO - 'SHELL': '/bin/bash', 04:21:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujFPYN20NN/Listeners', 04:21:36 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 04:21:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:36 INFO - 'USER': 'cltbld', 04:21:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:36 INFO - 'XPC_FLAGS': '0x0', 04:21:36 INFO - 'XPC_SERVICE_NAME': '0', 04:21:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:21:39 INFO - Installing collected packages: mozsystemmonitor 04:21:39 INFO - Running setup.py install for mozsystemmonitor 04:21:39 INFO - Successfully installed mozsystemmonitor 04:21:39 INFO - Cleaning up... 04:21:39 INFO - Return code: 0 04:21:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dc5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8858d94cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03d30>, '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 0x10d927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafab20>, '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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 04:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:21:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kNd5Hi7Hh/Render', 04:21:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:39 INFO - 'HOME': '/Users/cltbld', 04:21:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:39 INFO - 'LOGNAME': 'cltbld', 04:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:39 INFO - 'MOZ_NO_REMOTE': '1', 04:21:39 INFO - 'NO_EM_RESTART': '1', 04:21:39 INFO - 'PAGER': '/bin/cat', 04:21:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:39 INFO - 'PWD': '/builds/slave/test', 04:21:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:39 INFO - 'SHELL': '/bin/bash', 04:21:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujFPYN20NN/Listeners', 04:21:39 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 04:21:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:39 INFO - 'USER': 'cltbld', 04:21:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:39 INFO - 'XPC_FLAGS': '0x0', 04:21:39 INFO - 'XPC_SERVICE_NAME': '0', 04:21:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:42 INFO - Downloading blobuploader-1.2.4.tar.gz 04:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:21:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:21:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:43 INFO - Downloading docopt-0.6.1.tar.gz 04:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:21:43 INFO - Installing collected packages: blobuploader, requests, docopt 04:21:43 INFO - Running setup.py install for blobuploader 04:21:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:21:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:21:43 INFO - Running setup.py install for requests 04:21:43 INFO - Running setup.py install for docopt 04:21:44 INFO - Successfully installed blobuploader requests docopt 04:21:44 INFO - Cleaning up... 04:21:44 INFO - Return code: 0 04:21:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:44 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')]} 04:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:44 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')]} 04:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:44 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 0x10dc5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8858d94cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03d30>, '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 0x10d927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafab20>, '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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 04:21:44 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 04:21:44 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 04:21:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kNd5Hi7Hh/Render', 04:21:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:44 INFO - 'HOME': '/Users/cltbld', 04:21:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:44 INFO - 'LOGNAME': 'cltbld', 04:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:44 INFO - 'MOZ_NO_REMOTE': '1', 04:21:44 INFO - 'NO_EM_RESTART': '1', 04:21:44 INFO - 'PAGER': '/bin/cat', 04:21:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:44 INFO - 'PWD': '/builds/slave/test', 04:21:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:44 INFO - 'SHELL': '/bin/bash', 04:21:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujFPYN20NN/Listeners', 04:21:44 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 04:21:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:44 INFO - 'USER': 'cltbld', 04:21:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:44 INFO - 'XPC_FLAGS': '0x0', 04:21:44 INFO - 'XPC_SERVICE_NAME': '0', 04:21:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:44 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-8KzS5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:44 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-Ewmfa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:44 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-vDTjGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:44 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-wslPcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:44 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-EGSy8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:44 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-9NHGmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:45 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-evcZUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:45 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-txV8NT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:45 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-_bpAcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:45 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-PQcHzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:45 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-0l_SRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:45 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-MKkGCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:45 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-2IhQyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:45 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-qRhE0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:45 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-zWxGjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:46 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-IbzF9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:46 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-6914B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:21:46 INFO - Running setup.py install for manifestparser 04:21:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:21:46 INFO - Running setup.py install for mozcrash 04:21:46 INFO - Running setup.py install for mozdebug 04:21:46 INFO - Running setup.py install for mozdevice 04:21:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:21:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:21:46 INFO - Running setup.py install for mozfile 04:21:47 INFO - Running setup.py install for mozhttpd 04:21:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:21:47 INFO - Running setup.py install for mozinfo 04:21:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:21:47 INFO - Running setup.py install for mozInstall 04:21:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:21:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:21:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:21:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:21:47 INFO - Running setup.py install for mozleak 04:21:47 INFO - Running setup.py install for mozlog 04:21:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:21:47 INFO - Running setup.py install for moznetwork 04:21:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:21:47 INFO - Running setup.py install for mozprocess 04:21:48 INFO - Running setup.py install for mozprofile 04:21:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:21:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:21:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:21:48 INFO - Running setup.py install for mozrunner 04:21:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:21:48 INFO - Running setup.py install for mozscreenshot 04:21:48 INFO - Running setup.py install for moztest 04:21:48 INFO - Running setup.py install for mozversion 04:21:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:21:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:21:48 INFO - Cleaning up... 04:21:48 INFO - Return code: 0 04:21:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:48 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 0x10dc5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8858d94cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03d30>, '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 0x10d927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafab20>, '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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 04:21:48 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 04:21:48 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 04:21:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kNd5Hi7Hh/Render', 04:21:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:48 INFO - 'HOME': '/Users/cltbld', 04:21:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:48 INFO - 'LOGNAME': 'cltbld', 04:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:48 INFO - 'MOZ_NO_REMOTE': '1', 04:21:48 INFO - 'NO_EM_RESTART': '1', 04:21:48 INFO - 'PAGER': '/bin/cat', 04:21:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:48 INFO - 'PWD': '/builds/slave/test', 04:21:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:48 INFO - 'SHELL': '/bin/bash', 04:21:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujFPYN20NN/Listeners', 04:21:48 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 04:21:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:48 INFO - 'USER': 'cltbld', 04:21:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:48 INFO - 'XPC_FLAGS': '0x0', 04:21:48 INFO - 'XPC_SERVICE_NAME': '0', 04:21:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:49 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-BuYElL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:49 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)) 04:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:49 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-YdoVr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:49 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)) 04:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:49 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-nAbTFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:49 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)) 04:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:49 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-39QY4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:49 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)) 04:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:49 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-GrMha4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:49 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)) 04:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:49 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-GvF6AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:49 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)) 04:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:49 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-3lQHi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:49 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)) 04:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:49 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-O9ISF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:49 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)) 04:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:49 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-JVM8RP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:50 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)) 04:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:50 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-4Y2BjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:50 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)) 04:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:50 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-Vy8o5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:50 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)) 04:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:50 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-UtLB5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:50 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)) 04:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:50 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-RniZV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:50 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)) 04:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:50 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-DXrmhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:50 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)) 04:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:50 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-atHnQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:50 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)) 04:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:50 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-_MTVUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:50 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)) 04:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:50 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-LgHnSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:50 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)) 04:21:50 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)) 04:21:50 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)) 04:21:50 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)) 04:21:50 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)) 04:21:50 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)) 04:21:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:53 INFO - Downloading blessings-1.6.tar.gz 04:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:21:53 INFO - Installing collected packages: blessings 04:21:53 INFO - Running setup.py install for blessings 04:21:53 INFO - Successfully installed blessings 04:21:53 INFO - Cleaning up... 04:21:53 INFO - Return code: 0 04:21:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:21:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:53 INFO - Reading from file tmpfile_stdout 04:21:53 INFO - Current package versions: 04:21:53 INFO - blessings == 1.6 04:21:53 INFO - blobuploader == 1.2.4 04:21:53 INFO - docopt == 0.6.1 04:21:53 INFO - manifestparser == 1.1 04:21:53 INFO - mozInstall == 1.12 04:21:53 INFO - mozcrash == 0.16 04:21:53 INFO - mozdebug == 0.1 04:21:53 INFO - mozdevice == 0.48 04:21:53 INFO - mozfile == 1.2 04:21:53 INFO - mozhttpd == 0.7 04:21:53 INFO - mozinfo == 0.9 04:21:53 INFO - mozleak == 0.1 04:21:53 INFO - mozlog == 3.1 04:21:53 INFO - moznetwork == 0.27 04:21:53 INFO - mozprocess == 0.22 04:21:53 INFO - mozprofile == 0.28 04:21:53 INFO - mozrunner == 6.11 04:21:53 INFO - mozscreenshot == 0.1 04:21:53 INFO - mozsystemmonitor == 0.0 04:21:53 INFO - moztest == 0.7 04:21:53 INFO - mozversion == 1.4 04:21:53 INFO - psutil == 3.1.1 04:21:53 INFO - requests == 1.2.3 04:21:53 INFO - wsgiref == 0.1.2 04:21:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:53 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 0x10dc5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8858d94cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03d30>, '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 0x10d927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafab20>, '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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 04:21:53 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 04:21:53 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 04:21:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kNd5Hi7Hh/Render', 04:21:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:53 INFO - 'HOME': '/Users/cltbld', 04:21:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:53 INFO - 'LOGNAME': 'cltbld', 04:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:53 INFO - 'MOZ_NO_REMOTE': '1', 04:21:53 INFO - 'NO_EM_RESTART': '1', 04:21:53 INFO - 'PAGER': '/bin/cat', 04:21:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:53 INFO - 'PWD': '/builds/slave/test', 04:21:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:53 INFO - 'SHELL': '/bin/bash', 04:21:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujFPYN20NN/Listeners', 04:21:53 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 04:21:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:53 INFO - 'USER': 'cltbld', 04:21:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:53 INFO - 'XPC_FLAGS': '0x0', 04:21:53 INFO - 'XPC_SERVICE_NAME': '0', 04:21:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:54 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)) 04:21:54 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)) 04:21:54 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)) 04:21:54 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)) 04:21:54 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)) 04:21:54 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)) 04:21:54 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)) 04:21:54 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)) 04:21:54 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)) 04:21:54 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)) 04:21:54 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)) 04:21:54 INFO - Cleaning up... 04:21:54 INFO - Return code: 0 04:21:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21: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')]} 04:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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')]} 04:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8858d94cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03d30>, '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 0x10d927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafab20>, '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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 04:21: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', 'jsonschema'] in /builds/slave/test/build 04:21: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 jsonschema 04:21:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kNd5Hi7Hh/Render', 04:21:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:54 INFO - 'HOME': '/Users/cltbld', 04:21:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:54 INFO - 'LOGNAME': 'cltbld', 04:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:54 INFO - 'MOZ_NO_REMOTE': '1', 04:21:54 INFO - 'NO_EM_RESTART': '1', 04:21:54 INFO - 'PAGER': '/bin/cat', 04:21:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:54 INFO - 'PWD': '/builds/slave/test', 04:21:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:54 INFO - 'SHELL': '/bin/bash', 04:21:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujFPYN20NN/Listeners', 04:21:54 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 04:21:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:54 INFO - 'USER': 'cltbld', 04:21:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:54 INFO - 'XPC_FLAGS': '0x0', 04:21:54 INFO - 'XPC_SERVICE_NAME': '0', 04:21:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:54 INFO - Downloading/unpacking jsonschema 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:21:56 INFO - Downloading/unpacking functools32 (from jsonschema) 04:21:56 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 04:21:56 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 04:21:56 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 04:21:56 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 04:21:56 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 04:21:56 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 04:21:57 INFO - Downloading functools32-3.2.3-2.tar.gz 04:21:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:21:57 INFO - warning: no files found matching '*.txt' 04:21:57 INFO - no previously-included directories found matching 'build' 04:21:57 INFO - no previously-included directories found matching 'dist' 04:21:57 INFO - no previously-included directories found matching '.git*' 04:21:57 INFO - Installing collected packages: jsonschema, functools32 04:21:57 INFO - Running setup.py install for functools32 04:21:57 INFO - warning: no files found matching '*.txt' 04:21:57 INFO - no previously-included directories found matching 'build' 04:21:57 INFO - no previously-included directories found matching 'dist' 04:21:57 INFO - no previously-included directories found matching '.git*' 04:21:57 INFO - Successfully installed jsonschema functools32 04:21:57 INFO - Cleaning up... 04:21:57 INFO - Return code: 0 04:21:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:21: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')]} 04:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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')]} 04:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8858d94cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03d30>, '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 0x10d927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafab20>, '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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 04:21: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', 'flake8'] in /builds/slave/test/build 04:21: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 flake8 04:21:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kNd5Hi7Hh/Render', 04:21:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:57 INFO - 'HOME': '/Users/cltbld', 04:21:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:57 INFO - 'LOGNAME': 'cltbld', 04:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:57 INFO - 'MOZ_NO_REMOTE': '1', 04:21:57 INFO - 'NO_EM_RESTART': '1', 04:21:57 INFO - 'PAGER': '/bin/cat', 04:21:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:57 INFO - 'PWD': '/builds/slave/test', 04:21:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:57 INFO - 'SHELL': '/bin/bash', 04:21:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujFPYN20NN/Listeners', 04:21:57 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 04:21:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:57 INFO - 'USER': 'cltbld', 04:21:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:57 INFO - 'XPC_FLAGS': '0x0', 04:21:57 INFO - 'XPC_SERVICE_NAME': '0', 04:21:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:57 INFO - Downloading/unpacking flake8 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:22:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:22:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:22:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:22:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:22:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:22:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:22:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:22:01 INFO - no previously-included directories found matching 'docs/_build' 04:22:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:22:01 INFO - Running setup.py install for pep8 04:22:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:22:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:22:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:22:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:22:01 INFO - no previously-included directories found matching 'docs/_build' 04:22:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:22:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:22:01 INFO - Cleaning up... 04:22:01 INFO - Return code: 0 04:22:01 INFO - Running post-action listener: _resource_record_post_action 04:22:01 INFO - Running post-action listener: _start_resource_monitoring 04:22:01 INFO - Starting resource monitoring. 04:22:01 INFO - ##### 04:22:01 INFO - ##### Running install step. 04:22:01 INFO - ##### 04:22:01 INFO - Running pre-action listener: _resource_record_pre_action 04:22:01 INFO - Running main action method: install 04:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:02 INFO - Reading from file tmpfile_stdout 04:22:02 INFO - Detecting whether we're running mozinstall >=1.0... 04:22:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:22:02 INFO - Reading from file tmpfile_stdout 04:22:02 INFO - Output received: 04:22:02 INFO - Usage: mozinstall [options] installer 04:22:02 INFO - Options: 04:22:02 INFO - -h, --help show this help message and exit 04:22:02 INFO - -d DEST, --destination=DEST 04:22:02 INFO - Directory to install application into. [default: 04:22:02 INFO - "/builds/slave/test"] 04:22:02 INFO - --app=APP Application being installed. [default: firefox] 04:22:02 INFO - mkdir: /builds/slave/test/build/application 04:22:02 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'] 04:22:02 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 04:22:36 INFO - Reading from file tmpfile_stdout 04:22:36 INFO - Output received: 04:22:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:22:36 INFO - Running post-action listener: _resource_record_post_action 04:22:36 INFO - ##### 04:22:36 INFO - ##### Running run-tests step. 04:22:36 INFO - ##### 04:22:36 INFO - Running pre-action listener: _resource_record_pre_action 04:22:36 INFO - Running main action method: run_tests 04:22:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:22:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:22:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:22:36 INFO - 2016-02-22 04:22:36.662 screenresolution[7109:171901] starting screenresolution argv=screenresolution get 04:22:36 INFO - 2016-02-22 04:22:36.665 screenresolution[7109:171901] Display 0: 1600x1200x32@60 04:22:36 INFO - 2016-02-22 04:22:36.671 screenresolution[7110:171903] starting screenresolution argv=screenresolution list 04:22:36 INFO - Available Modes on Display 0 04:22:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:22:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:22:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:22:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:22:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:22:36 INFO - Intel Iris: 04:22:36 INFO - Chipset Model: Intel Iris 04:22:36 INFO - Type: GPU 04:22:36 INFO - Bus: Built-In 04:22:36 INFO - VRAM (Dynamic, Max): 1536 MB 04:22:36 INFO - Vendor: Intel (0x8086) 04:22:36 INFO - Device ID: 0x0a2e 04:22:36 INFO - Revision ID: 0x0009 04:22:36 INFO - Displays: 04:22:36 INFO - Display: 04:22:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:22:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:22:36 INFO - Display Serial Number: 1600x1200 60 04:22:36 INFO - Main Display: Yes 04:22:36 INFO - Mirror: Off 04:22:36 INFO - Online: Yes 04:22:36 INFO - Rotation: Supported 04:22:36 INFO - Return code: 0 04:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:22:36 INFO - Python 2.7.3 04:22:36 INFO - Return code: 0 04:22:36 INFO - grabbing minidump binary from tooltool 04:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:36 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 0x10db03d30>, '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 0x10d927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:22:36 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 04:22:36 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 04:22:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:22:36 INFO - Return code: 0 04:22:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:22:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:22:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:22:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:22:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:22:38 INFO - Return code: 0 04:22:38 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/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--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 04:22:38 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/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0059 --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 04:22:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kNd5Hi7Hh/Render', 04:22:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:38 INFO - 'HOME': '/Users/cltbld', 04:22:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:38 INFO - 'LOGNAME': 'cltbld', 04:22:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:22:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:38 INFO - 'MOZ_NO_REMOTE': '1', 04:22:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:22:38 INFO - 'NO_EM_RESTART': '1', 04:22:38 INFO - 'PAGER': '/bin/cat', 04:22:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:38 INFO - 'PWD': '/builds/slave/test', 04:22:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:22:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:38 INFO - 'SHELL': '/bin/bash', 04:22:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujFPYN20NN/Listeners', 04:22:38 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 04:22:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:38 INFO - 'USER': 'cltbld', 04:22:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:38 INFO - 'XPC_FLAGS': '0x0', 04:22:38 INFO - 'XPC_SERVICE_NAME': '0', 04:22:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:38 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/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--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 04:22:38 INFO - mozversion application_buildid: 20160222032957 04:22:38 INFO - mozversion application_changeset: dec30ce4ea4ce5ed23dc40f2a8af7337bce7bc70 04:22:38 INFO - mozversion application_display_name: Nightly 04:22:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:22:38 INFO - mozversion application_name: Firefox 04:22:38 INFO - mozversion application_remotingname: firefox 04:22:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:22:38 INFO - mozversion application_vendor: Mozilla 04:22:38 INFO - mozversion application_version: 47.0a1 04:22:38 INFO - mozversion platform_buildid: 20160222032957 04:22:38 INFO - mozversion platform_changeset: dec30ce4ea4ce5ed23dc40f2a8af7337bce7bc70 04:22:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:22:38 INFO - mozversion platform_version: 47.0a1 04:22:38 INFO - using testdate: 1456143758 04:22:38 INFO - actual date: 1456143758 04:22:38 INFO - starting webserver on 'localhost:58697' 04:22:38 INFO - SUITE-START | Running 2 tests 04:22:38 INFO - TEST-START | dromaeo_css 04:22:38 INFO - operating with platform_type : mac_ 04:22:38 INFO - Initialising browser for dromaeo_css test... 04:22:38 INFO - TEST-INFO | started process 7128 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmp9ryAyA/profile http://localhost:58697/getInfo.html) 04:22:41 INFO - PROCESS | 7128 | __metrics Screen width/height:1600/1200 04:22:41 INFO - PROCESS | 7128 | colorDepth:24 04:22:41 INFO - PROCESS | 7128 | Browser inner width/height: 1024/689 04:22:41 INFO - PROCESS | 7128 | __metrics 04:22:41 ERROR - PROCESS | 7128 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 04:22:42 INFO - TEST-INFO | 7128: exit 0 04:22:42 INFO - Browser initialized. 04:22:42 INFO - Running cycle 1/1 for dromaeo_css test... 04:22:42 INFO - TEST-INFO | started process 7132 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmp9ryAyA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:54 INFO - PROCESS | 7132 | RSS: Main: 255209472 04:22:54 INFO - PROCESS | 7132 | 04:23:44 INFO - PROCESS | 7132 | 1456143824153 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] 04:25:55 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:58697/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58697/tests/dromaeo/cssquery-ext.html) 04:25:56 INFO - PROCESS | 7132 | RSS: Main: 270004224 04:25:56 INFO - PROCESS | 7132 | 04:28:58 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:58697/tests/dromaeo/cssquery-ext.html (next: http://localhost:58697/tests/dromaeo/cssquery-jquery.html) 04:28:59 INFO - PROCESS | 7132 | RSS: Main: 280920064 04:28:59 INFO - PROCESS | 7132 | 04:32:01 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:58697/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58697/tests/dromaeo/cssquery-mootools.html) 04:32:01 INFO - PROCESS | 7132 | RSS: Main: 281948160 04:32:01 INFO - PROCESS | 7132 | 04:35:03 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:58697/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58697/tests/dromaeo/cssquery-prototype.html) 04:35:04 INFO - PROCESS | 7132 | RSS: Main: 283430912 04:35:04 INFO - PROCESS | 7132 | 04:38:06 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:58697/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58697/tests/dromaeo/cssquery-yui.html) 04:38:07 INFO - PROCESS | 7132 | RSS: Main: 285986816 04:38:07 INFO - PROCESS | 7132 | 04:41:09 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:58697/tests/dromaeo/cssquery-yui.html (next: http://localhost:58697/tests/dromaeo/cssquery-dojo.html) 04:41:10 INFO - PROCESS | 7132 | RSS: Main: 287232000 04:41:10 INFO - PROCESS | 7132 | 04:41:10 INFO - PROCESS | 7132 | __start_tp_report 04:41:10 INFO - PROCESS | 7132 | _x_x_mozilla_page_load 04:41:10 INFO - PROCESS | 7132 | _x_x_mozilla_page_load_details 04:41:10 INFO - PROCESS | 7132 | |i|pagename|runs| 04:41:10 INFO - PROCESS | 7132 | |0;dojo.html;3452.0506860613336;3470.167159881626;3474.200933785228;3536.5579302587175;3538.823058847058;5000.824971126011;5115.258287548303;5753.5109515691165;5763.740631671574;5765.279340082489;5613.80351687691;5753.626014309067;5784.450477204669;5867.853303667411;5889.911651325234;5153.458886816896;5178.404483484391;5189;5206.167013277876;5261.789528418859;5231.26762253283;5266.683998960056;5267.051930652481;5272.393674727398;5299;4956.776945037446;5051.64638475305;5113.488651134894;5199.974000129975;5210.088234558937;5189.351331083614;5209.661372010807;5229.947700522984;5247.449017853147;5297.814576489843;3985.9437249129005;5144.639875208737;5206.479352064801;5228.947710522884;5231.372235331746;5542.86142846428;5655.434456554352;5684.204211410406;5693.658380497183;5700.116481945305;6243.250809902841;6314.684265786738;6316.494680425555;6326.557141000132;6335.081413195061;6213.502919766408;6218.067289906505;6251.906221406637;6295.842603934938;6299.65351905645;5845.883082338372;5885;5920.644761314335;5949.643021418642;5992.34084250732;6217.658028808459;6287.151234583364;6287.685615719287;6294.370562943669;6296.811095667137;6118.040554665137;6222.657753823492;6240.219972503437;6246.250449945945;6254.999200128049;6202.596831205957;6237;6308.337624549448;6331.018692102732;6340.4293613575;4864.513548645107;6207.068939659087;6252.3122456529745;6290.559660823698;6320.209973753281;6267.843303917439;6273.560850740404;6291.622502649856;6298.212723409574;6319.115323854664;4902.0441014002645;4944.085344211332;4950.925736113961;4955.653104282737;4963.181075122637;4322.502912165079;4394.560543945579;4397.6042156206095;4441.822327106945;4486.528914463935;5734.6845923473775;5754.539636829128;5759.280089988752;5808.419158084243;5809.50619197373;5094.64478255661;6213.03697926813;6246.625202487865;6263.279722831841;6299.6850157491945;5759.539236861041;5763.538916886639;5800.071988481823;5817.680027598438;5852.063669812809;5404.297441332602;5416.295881535454;5435.402105768362;5441.6190866639745;5456.536194423518;6236.968815155895;6304.6847657617855;6347.96826015867;6422.389872962061;6431;4996.500349964975;5851.268591426072;6220.657863817533;6261.405166509175;6287.842803929755;6362.522810789302;6397.104405383157;6401.039844023434;6410.102585637921;6420.454261387835;6094.603850749687;6191.102290167991;6312.5581209314905;6314.6842657866;6332.145160403286;6203.503719702323;6217.782377616762;6260.248770147611;6265.467435268053;6279;5276.709780962084;6074.331823499323;6160.630362178284;6246.562740608114;6247;5305.779670675689;6126.945200426759;6182.629042257479;6230.470410015199;6243.37566243372;5245;5944.702764861653;5971.0744834550715;6010.3088144863905;6106.938930610815;5927.140564618193;6135.478484328882;6245.687715614292;6251.78118765841;6265.028920517327;6095.299040610386;6137.508999279958;6149.323574406722;6157.9384206157365;6174.845628859135 04:41:10 INFO - PROCESS | 7132 | |1;ext.html;438.4672622763344;453.58496975267633;486.47946697034166;521.9034478621455;593.6883136353416;29484.410311793752;38185.809070954674;38251.61748382515;38279.61720382799;38393.42409863854;39943.400848987214;40529;40558.79720601393;40606.18787624246;40607.78176654705;9368.57841397137;9525.095115963972;9549.379290346105;9576.760580985461;9621.759456013586;9377.202937750299;9578.952105239465;9604.807903841918;9638.807223855518;9654.227661787076;9576.569054392534;9589.18491928187;9638.180754635865;9671.274654400948;9673.032696730306;9561.28290378221;9572.377795443308;9617.134457898752;9620.903790962106;9624.085711857362;9515.381500202464;9625.085616866387;9691.030896910323;9697.806043879153;9725.221982241404;38270.80864595659;38381.232375352614;38463.615363846286;38606.8417947462;38684.806575967224;2887.5524293734293;3279.6392396836327;3347.6484969078138;3424.2637832865803;3640.672339489459;27103.728962710316;27563.586546201823;27729.722702772917;28026.579601305995;28299.717002829915;2742;2763.5163846327014;2786.1084452975056;2805.6633204015443;2842.3888863894153;366547;423758;427251;432016.99999999686;435010;45889.31166032512;46508;46561.5343846564;47379.289310660366;65351.346486535476;31442.685573144434;41397.79301103475;45349.773251133534;45568.3164752529;45669.771651141535;15219.010764300285;15270.236488175547;15296.694066118615;15375.461858834888;15514.224288785515;12151.696207594881;12262.141650084408;12332.075094367958;12334.81497777534;12460.563880264148;14603.634909127144;14645.828333733276;14668.413263469554;14682.265886705622;14724;6252.3122456529745;6360.459360954371;6386.552941294065;6395.20059992501;6404.967975160094;774.71722821171;982.9852552211722;1018.7198520406799;1097.8023955688052;1186.810110382352;25602.615960760602;29336.706632933823;30341.24146896301;30344;30397.392052158833;945.721012301359;1084.414416215235;1099.7792450380073;1114.8383484394878;1167.5971789732528;11680.474378652982;14561.466642675927;14614.561563153122;14893.553193404216;15092.698146037017;580089;598315;651866;674620;675787;57933.710331448914;57946.13080803792;58246.41753582495;58311;59018;1433.978490322646;1497.423491955605;1497.490853109948;1501.3018946190075;1506.4200282891165;28943;29075.273118172216;29113.126606201848;29300;29724.851375742983;49367.7531612354;50043.49956500388;50191.745206370135;50687.98624027425;50724;487598;490000;491402;493659;495389;33155;33937;34275.65724342824;34430.311393772485;34616.30767384689;44310.55689443064;45775.542244577126;46166.53833461623;46229;46229.76885115553;27899.721002789713;30481.390372192876;35734;38136;38728.80635596804;36805.26389472249;36899.81550092233;37822.81088594539;37960.240795184494;37961.62038379581;36784.44823327599;37140;37471.06322341963;37502;37783.43324850075;25277.87361063183;29279.85360073186;30195.4902254882;34095.31809363848;34899.65100349065;18835.529111771768;20696.846464375696;24224.75775242225;25095.117866159744;25643.358916026504 04:41:10 INFO - PROCESS | 7132 | |2;jquery.html;324.4597744754983;327.9737620990321;343.34935297611014;351.9630438803927;357.2747322934444;15700.528984130495;19283.132259048358;19549.315773947914;19798.802011979875;19934;19862;20120.39638810838;21134.15463381467;21824.563508729814;21865;4682.765861706901;6335.239771227459;6589.143411356529;6645.734170633169;6652.368025037614;7226.458015648821;7594.240575942416;7601.3538849197885;7606.125295590995;7626.809329766745;6930.826729331782;7193.460490463236;7249.637518124099;7551.735689250877;7553.24467553243;6597.835054123685;6885.173779146509;7152.070230869979;7205.67574459148;7575;7201.531900426456;7208.747693830744;7212.206657267697;7213.783586492414;7221.530600511002;26171;27119.593206101923;27130.1860944172;27189.45621087587;27784.58323125155;2198.758136604972;2254.6730724045087;2315.502167034079;2350.659154422599;2975.4792911240447;13263.204207747469;14913.03065300752;15257;15545.378184872592;15603.609909752233;1578.6132397562556;1837.9632407351778;1874.3533480949052;1886.56608979934;1896.421591414618;70652.6467367665;114253.99999999917;115260;115724.05655660602;116176;19262.518437038907;19880.50298742514;20007.799922000886;20070.89964550168;20089.296874609612;28877;28966.42067158645;29301.413971720445;29314.82740690391;29329.413411731646;10632.681019569425;10790.406527641055;10811.513481893333;10860.782784344268;10882.836757448644;7412.221716719775;7944.682212711542;8785.209331160226;9097.77255568616;9258.90741092594;6194.5354098442795;7324.194338622748;8251.133630968781;8604.225619694258;8710.651573936972;3465.5841299043773;3549.254656522108;3553.6446355364255;3554.1211618589027;3696.2607478504406;812.8333691593209;914.350810924238;929.8837645294338;977.9511024448749;1047.298310132198;19035;19471.4158575243;19962.20151193965;20700;21463.57072858565;783.9608019598998;946.1059298962552;972.2999440402899;972.8103019911049;1051.805415998043;11047.934146269039;11443.656690299304;11495.310281383145;11617.244879082833;11688.532458701728;547386;669945;678078;679266;685176.5741171262;117583.41208293904;121995;123685;124096.37951810184;128893;1023.6928921323573;1028.7890982348601;1043.1498328862106;1044.5038606661774;1049.821530339844;18261.90869045646;18379.26482940721;18551.90724046371;18559.979201144066;18852.34016809405;50814.23778643397;51724.74137629288;55462.168067479826;55957;60818.695906521956;61287;74333.62833186016;78138;80603;86009;11522.942385288019;11935.462904169159;12072.215306005082;12245.571405000783;12309.692257693629;9139.954300228455;9162.404443711137;9346.485943273185;12207.938960305142;14159.787603186167;6310.49516038725;7099.396551292992;8277.710280140167;8308.958455207685;8619.82760344802;7346.265373462611;7942.6028698566;8138.186181381814;8367.288780453486;8369.163083691583;8482.066972632882;8505.319574433906;8544.273736732448;8565.528895910535;8617.569121544024;11916.821247681119;12015.339156346135;12284.754304914031;12304.507819687113;12389.194702344319;10102.595896164072;10211.591536338761;12075.51697932073;12085.093617978511;12191 04:41:10 INFO - PROCESS | 7132 | |3;mootools.html;1475.6089636246393;1480.9703805923882;1705.4968784208656;1881.1064744246476;1887.3582981786199;8083.595820208995;8623.655053797856;8753.080926502713;8890.466572005676;8953.104689531052;8594.398392112555;8612.526311052905;8647.178518040777;8750.343724220693;8759.167879051496;2484.987575062127;2488.688913885764;2512.811539134563;2513.49730053989;2514.120057979711;2467.1734968785477;2521.2688320387065;2527.5576774064466;2528.40582463121;2538.1370334086405;2187.3547303545492;2433.0875921529428;2475.653408522808;2498.600223964166;2508.9372765680914;2455.2143314139485;2456.9262922112184;2464.8521088734733;2484.689413823272;2500.824942254034;2444.2667199840153;2468.148488771371;2470.0737223541173;2485.9129930452527;2495.1142344467635;8602.483850968962;8692.261157801595;8739.563021848882;8752.47485150893;8758.912410875873;5413.458654134594;5580.38615752271;5581.832545023615;5595.468430499096;5604.579656525777;3670.541182352206;3689.4834723138783;3692.3169213695282;3821.14024344523;3839.520059992501;1053.984190237147;1060.0247772049734;1068.417712346765;1102;1102.1127991966464;11865.82201266973;11975.760484790255;12015.219010764273;12062.155649104567;12065.095117866107;4157.563455837154;4946.950530494721;5024.824131155392;5030.0191462664425;5047.268146118792;10291.691249262534;10291.794164116676;10292;10323.587056517805;10358.378497290187;5562.360328562187;5574.804881829116;5576.860578485489;5598.384177740445;5606;4994.90010199794;5005.7997680092385;5078.415982162099;5081.9745901271;5096.0827051131155;3991.84032638697;4003;4016.5180178378196;4035.8385664573675;4053.0880551875593;1090.7436752363346;1285.8264134341932;1330.8735670111323;1340.3298350824587;1358.6060042587737;1128.7347473343757;1134.65393055119;1151.073385924339;1325.4631874091008;1397.6645605054916;7963.124056353797;8010.5994700264755;8041;8086.636101375452;8091.271785539329;1168.5384273212035;1174.6945794093597;1188.5008296515484;1197.4312201704122;1215.3437143942172;6201.193844800147;6211.378862113843;6236.03341482071;6249.375062493714;6303.023031430135;10532.789344213073;10689.9465502672;10715.089217416607;10839.891601083888;10875.238733288752;9548.331616786898;9892.604295828087;10222.437765922798;10710.625128120635;10726.517306721216;8289.171082891784;8315.210055044761;8344.499330040095;8357;8400.243978042006;6808.206745718787;7972.681092756225;8028.879566806386;8031.357491400557;8253.504789712637;9664.226861850895;9904.752381190528;9917.958614345389;9972.800543988935;10026.69919902404;10000.399976001463;10137.594496220068;10152.695419137437;10161.847572286273;10262.743431414274;7475.850482990419;7493.662785174572;7586.810329741801;7668.884966725392;7686.423518236043;8143.75568732939;8227.465214761261;8245.546494942835;8274;8342.666293348198;6220.813375598739;6929.376356127973;7539.246075392417;7559.735409260649;7691.30778229962;7107.18267399235;7232.566046037255;7242.094738157731;7254.383377412768;7288.890666640111;7856.960715196387;7876.330511906552;7901.604919754104;7916.643751031333;7932.484388514728;7043.7534686285735;7120.750773722895;7174.067371241914;7180;7181.605011724405;6170.629762214281;7170;7196.856062878608;7241.782746517613;7315.451341149329 04:41:10 INFO - PROCESS | 7132 | |4;prototype.html;284.38572683004713;288.20455542702143;335.2774770369853;339.9048266485385;342.6607658418165;6763.256041835407;6789.66051697415;6827.31726827317;7024.26245244249;7059.1529016518025;5972.432618901208;6820.147481564804;6912.8271793205195;6952.756653517128;7004.614746188958;4528.50186479487;4742.668013239075;4987.376577927759;5017.64876458648;5020.924686129692;4997.4003119625695;5002.549770520653;5005.374328208974;5032.572231360339;5038.1687021641565;4927.876803079916;4960.429550601672;4961.107000739883;4965.0814599299065;4974.726390048546;4678.204705200124;4895.804167833282;4957.405111386621;4958.983408401287;4962.826301079463;4117.07365842686;4117.732347397409;4118.373242569169;4134.37984302354;4148.647364973981;6436.452901503378;6438.195225596801;6502.772402965921;6507.44686701631;6567;4707.693999890031;4760.547747963972;5608.691521966291;5848;5862.296524417055;5866.853328666774;7212.206657267697;7218.061651985261;7233.710651573931;7261.128664560234;4663.930041049387;4676.251799712029;4678.251479763256;4679.578837904605;4686.08621318843;7665.156832748393;7748.806279842993;7750.302472777477;7776.883346749803;7784.688612455495;4000.839756470591;4577.6453878324155;4662.090892275974;4673.719576825333;4743.739094349844;4799.856004319876;4827.275908613736;4827.806887724522;4828.46886842447;4850.466448690641;4716.88207794801;5836.270466191726;5839.153322768175;5857.88284234313;5864.824055278264;7351.4853960223345;7354.154272258758;7361.337479626753;7388.224236455095;7391;1377.4008306386754;1647.3739978808217;1674.7487876818575;1684.292597109217;1690.163369132263;866.3545658484344;987.4963768477984;994.5077186792583;1038.1694644284541;1057.7408534908996;5736.541076713853;6719;6728.831779205461;6739.393454589012;6760.121184246016;6120;7588.544687318778;7596.658150383246;7604.505707129019;7670.463067585216;5450.591205659592;6741.494387920828;6743.763968261087;6748.392644662004;6758.256591774901;3421.2815308784934;3995.72029957906;3996.640302372742;4000.319945609195;4019.41718450823;7806.60412720457;8034.919650803534;8075.475094118863;8083.878741818878;8098.068722097034;7985.800354991055;7995.080565734898;8000.8799868002025;8007.919920800718;8017.118117007125;8015.877777111209;8051.315638170704;8069.798255043554;8070.757877263574;8092.312153467021;7454.58999754997;7696.422768292512;7712.997310349619;7723.691052357843;7771.805704857197;7540.359069478936;7552.207018263003;7558.319751222197;7570.394368450621;7585.2035536267895;8010.8397832041865;8014.599270036591;8030.156833532628;8043.638036288498;8047.1550487198;4781.521847815191;4813.687110337817;4827.444843843003;4827.903441931212;4839.854804355875;7353.963230183815;7688.923110768821;7712.768616941501;7739.535627862347;7745.496542724705;7321.524100933422;7376.4098872089035;7395.889061664187;7397;7437.776866694008;7373.852522949618;7385.556866588022;7393.704251829867;7395.260473952561;7399.852002960019;7205.594908992696;7210.531315464478;7211.098612673416;7214.855702886018;7232.819179520554;7101.573905565682;7321.524100933422;7336.559806411632;7359.705611775469;7369.410447164107;5799.362070172362;6953.235144134243;7133.536320139175;7139.607321597362;7146.392556632536 04:41:10 INFO - PROCESS | 7132 | |5;yui.html;634.8984162533992;646.8835609590271;670.0652589637455;671.3085521912426;693.4140651149777;12831.230126192411;14688.853111468881;14853.77719334208;14935.626609334759;15009.399624015039;12938.805917911215;14165.008449408546;14316.427342906298;14330.498432554836;14367.49713760016;704.989425158623;853.3940901959617;862.409249663979;872.2890843962182;872.9650813967434;769.5613500304828;849.4605925237488;864.8270345930807;868.8045189832301;872.0668884293776;891.5230351761809;914.1133100892124;916.3448134583771;923.2890674180877;927.7819712367589;878.9912100879005;898.6540182029933;912.5847739278646;913.7532866126109;913.9725808225763;658.4633523678187;667.559410788877;676.8104930619385;677.1366507702669;681.3901558105467;14777.70444591113;14797.482088126972;14818.629534261621;14845.257737113101;14892.329845156994;13124.737505249841;13206.207627542282;13223.338833058404;13263;13334.799978000337;9753.122219000325;10171.135453486462;10241.743956401075;10501.31741436804;10848.891511084867;3140.795848269878;3533.3639944809925;3575.767575107636;3605.8557657693923;3713.628637136265;62636;84605.73091403634;84735.7289640656;84864;87013.56493217494;9362.859557106649;9473.147416732527;9531.523423828781;9641.566129524188;9910.37641904006;17644.647107057786;20782.376528704164;20904;20909.581808363746;21592.028358723896;7377.77866664001;7402.29678180572;7471.3649339806725;7551.962240188764;7663.27198916102;3984.940225896614;3994.1612261425425;4021.1354558770004;4049.230646177217;4147.253494370982;3589.4077477215965;3608.386574282378;3616.65641764032;3635.4365073413665;3640.508531348234;670.7216505150406;672.1195234243157;672.3847679373416;680.2687111355214;682.1984168601873;539.5791282799423;548.2078396716786;580.9651420914759;604.9516038716893;620.3703241210176;8154.75535733929;8305.584720764058;8434.789130271793;8526.957365213135;8714.259287960595;493.12224240851344;544.5235419008368;564.478729823131;585.5462016936908;591.4765432592187;4004.3192657248337;4030.717849750489;4032.778197199182;4054.8986275343354;4087.816048277835;90218;91725;97073.51463242639;98073.01926980639;98268;71618;72268.55462890712;72559.27440725631;73205;74225.6288718553;66896.33103668998;67085.66457167683;68369.63260734758;70917.29082709107;71962;7869.370450363843;8712.564371781513;8789.957189172092;8886.511241881759;9045.231155351605;47804.043919122116;48971;49472.763180919326;50419.747901260256;52132;68936.27659308357;69297.30702692909;70227;70530.64734676294;71495;10977.725556861142;11129.721756956142;11306.4912078955;11349.716257093638;11767.646970590897;10840;11636.185467017227;11959.581414650445;12629.179103358252;12736.23582585048;11477.655670329903;11527;11729.648110556696;11875.049996000473;11889.167758256839;9901.455419951972;10799.730006749895;10809.621663241749;11687.707807304545;11904.253576092495;11302.660920172408;11650.359230242419;11792.52829886795;11806.881931180922;12299.75400492003;8172.855800188097;9303.906960930304;9411.011843756307;9449.811003780023;10054.19566434698;7871.094824095073;9086.409383390059;9199.632014719336;9842.21262299;9931.65239216624 04:41:10 INFO - PROCESS | 7132 | __end_tp_report 04:41:10 INFO - PROCESS | 7132 | __start_cc_report 04:41:10 INFO - PROCESS | 7132 | _x_x_mozilla_cycle_collect,360 04:41:10 INFO - PROCESS | 7132 | __end_cc_report 04:41:10 INFO - PROCESS | 7132 | __startTimestamp1456144870047__endTimestamp 04:41:10 INFO - PROCESS | 7132 | 04:41:10 INFO - PROCESS | 7132 | ------- Summary: start ------- 04:41:10 INFO - PROCESS | 7132 | Number of tests: 6 04:41:10 INFO - PROCESS | 7132 | 04:41:10 INFO - PROCESS | 7132 | [#0] dojo.html Cycles:165 Average:5740.54 Median:5949.64 stddev:669.57 (11.3%) stddev-sans-first:647.11 04:41:10 INFO - PROCESS | 7132 | Values: 3452.1 3470.2 3474.2 3536.6 3538.8 5000.8 5115.3 5753.5 5763.7 5765.3 5613.8 5753.6 5784.5 5867.9 5889.9 5153.5 5178.4 5189.0 5206.2 5261.8 5231.3 5266.7 5267.1 5272.4 5299.0 4956.8 5051.6 5113.5 5200.0 5210.1 5189.4 5209.7 5229.9 5247.4 5297.8 3985.9 5144.6 5206.5 5228.9 5231.4 5542.9 5655.4 5684.2 5693.7 5700.1 6243.3 6314.7 6316.5 6326.6 6335.1 6213.5 6218.1 6251.9 6295.8 6299.7 5845.9 5885.0 5920.6 5949.6 5992.3 6217.7 6287.2 6287.7 6294.4 6296.8 6118.0 6222.7 6240.2 6246.3 6255.0 6202.6 6237.0 6308.3 6331.0 6340.4 4864.5 6207.1 6252.3 6290.6 6320.2 6267.8 6273.6 6291.6 6298.2 6319.1 4902.0 4944.1 4950.9 4955.7 4963.2 4322.5 4394.6 4397.6 4441.8 4486.5 5734.7 5754.5 5759.3 5808.4 5809.5 5094.6 6213.0 6246.6 6263.3 6299.7 5759.5 5763.5 5800.1 5817.7 5852.1 5404.3 5416.3 5435.4 5441.6 5456.5 6237.0 6304.7 6348.0 6422.4 6431.0 4996.5 5851.3 6220.7 6261.4 6287.8 6362.5 6397.1 6401.0 6410.1 6420.5 6094.6 6191.1 6312.6 6314.7 6332.1 6203.5 6217.8 6260.2 6265.5 6279.0 5276.7 6074.3 6160.6 6246.6 6247.0 5305.8 6126.9 6182.6 6230.5 6243.4 5245.0 5944.7 5971.1 6010.3 6106.9 5927.1 6135.5 6245.7 6251.8 6265.0 6095.3 6137.5 6149.3 6157.9 6174.8 04:41:10 INFO - PROCESS | 7132 | 04:41:10 INFO - PROCESS | 7132 | [#1] ext.html Cycles:180 Average:64180.70 Median:38261.21 stddev:139972.68 (365.8%) stddev-sans-first:140283.52 04:41:10 INFO - PROCESS | 7132 | Values: 438.5 453.6 486.5 521.9 593.7 29484.4 38185.8 38251.6 38279.6 38393.4 39943.4 40529.0 40558.8 40606.2 40607.8 9368.6 9525.1 9549.4 9576.8 9621.8 9377.2 9579.0 9604.8 9638.8 9654.2 9576.6 9589.2 9638.2 9671.3 9673.0 9561.3 9572.4 9617.1 9620.9 9624.1 9515.4 9625.1 9691.0 9697.8 9725.2 38270.8 38381.2 38463.6 38606.8 38684.8 2887.6 3279.6 3347.6 3424.3 3640.7 27103.7 27563.6 27729.7 28026.6 28299.7 2742.0 2763.5 2786.1 2805.7 2842.4 366547.0 423758.0 427251.0 432017.0 435010.0 45889.3 46508.0 46561.5 47379.3 65351.3 31442.7 41397.8 45349.8 45568.3 45669.8 15219.0 15270.2 15296.7 15375.5 15514.2 12151.7 12262.1 12332.1 12334.8 12460.6 14603.6 14645.8 14668.4 14682.3 14724.0 6252.3 6360.5 6386.6 6395.2 6405.0 774.7 983.0 1018.7 1097.8 1186.8 25602.6 29336.7 30341.2 30344.0 30397.4 945.7 1084.4 1099.8 1114.8 1167.6 11680.5 14561.5 14614.6 14893.6 15092.7 580089.0 598315.0 651866.0 674620.0 675787.0 57933.7 57946.1 58246.4 58311.0 59018.0 1434.0 1497.4 1497.5 1501.3 1506.4 28943.0 29075.3 29113.1 29300.0 29724.9 49367.8 50043.5 50191.7 50688.0 50724.0 487598.0 490000.0 491402.0 493659.0 495389.0 33155.0 33937.0 34275.7 34430.3 34616.3 44310.6 45775.5 46166.5 46229.0 46229.8 27899.7 30481.4 35734.0 38136.0 38728.8 36805.3 36899.8 37822.8 37960.2 37961.6 36784.4 37140.0 37471.1 37502.0 37783.4 25277.9 29279.9 30195.5 34095.3 34899.7 18835.5 20696.8 24224.8 25095.1 25643.4 04:41:10 INFO - PROCESS | 7132 | 04:41:10 INFO - PROCESS | 7132 | [#2] jquery.html Cycles:180 Average:37158.54 Median:29322.12 stddev:108184.80 (369.0%) stddev-sans-first:108452.94 04:41:10 INFO - PROCESS | 7132 | Values: 324.5 328.0 343.3 352.0 357.3 15700.5 19283.1 19549.3 19798.8 19934.0 19862.0 20120.4 21134.2 21824.6 21865.0 4682.8 6335.2 6589.1 6645.7 6652.4 7226.5 7594.2 7601.4 7606.1 7626.8 6930.8 7193.5 7249.6 7551.7 7553.2 6597.8 6885.2 7152.1 7205.7 7575.0 7201.5 7208.7 7212.2 7213.8 7221.5 26171.0 27119.6 27130.2 27189.5 27784.6 2198.8 2254.7 2315.5 2350.7 2975.5 13263.2 14913.0 15257.0 15545.4 15603.6 1578.6 1838.0 1874.4 1886.6 1896.4 70652.6 114254.0 115260.0 115724.1 116176.0 19262.5 19880.5 20007.8 20070.9 20089.3 28877.0 28966.4 29301.4 29314.8 29329.4 10632.7 10790.4 10811.5 10860.8 10882.8 7412.2 7944.7 8785.2 9097.8 9258.9 6194.5 7324.2 8251.1 8604.2 8710.7 3465.6 3549.3 3553.6 3554.1 3696.3 812.8 914.4 929.9 978.0 1047.3 19035.0 19471.4 19962.2 20700.0 21463.6 784.0 946.1 972.3 972.8 1051.8 11047.9 11443.7 11495.3 11617.2 11688.5 547386.0 669945.0 678078.0 679266.0 685176.6 117583.4 121995.0 123685.0 124096.4 128893.0 1023.7 1028.8 1043.1 1044.5 1049.8 18261.9 18379.3 18551.9 18560.0 18852.3 50814.2 51724.7 55462.2 55957.0 60818.7 61287.0 74333.6 78138.0 80603.0 86009.0 11522.9 11935.5 12072.2 12245.6 12309.7 9140.0 9162.4 9346.5 12207.9 14159.8 6310.5 7099.4 8277.7 8309.0 8619.8 7346.3 7942.6 8138.2 8367.3 8369.2 8482.1 8505.3 8544.3 8565.5 8617.6 11916.8 12015.3 12284.8 12304.5 12389.2 10102.6 10211.6 12075.5 12085.1 12191.0 04:41:10 INFO - PROCESS | 7132 | 04:41:10 INFO - PROCESS | 7132 | [#3] mootools.html Cycles:180 Average:6103.32 Median:5062.84 stddev:3187.49 (63.0%) stddev-sans-first:3177.45 04:41:10 INFO - PROCESS | 7132 | Values: 1475.6 1481.0 1705.5 1881.1 1887.4 8083.6 8623.7 8753.1 8890.5 8953.1 8594.4 8612.5 8647.2 8750.3 8759.2 2485.0 2488.7 2512.8 2513.5 2514.1 2467.2 2521.3 2527.6 2528.4 2538.1 2187.4 2433.1 2475.7 2498.6 2508.9 2455.2 2456.9 2464.9 2484.7 2500.8 2444.3 2468.1 2470.1 2485.9 2495.1 8602.5 8692.3 8739.6 8752.5 8758.9 5413.5 5580.4 5581.8 5595.5 5604.6 3670.5 3689.5 3692.3 3821.1 3839.5 1054.0 1060.0 1068.4 1102.0 1102.1 11865.8 11975.8 12015.2 12062.2 12065.1 4157.6 4947.0 5024.8 5030.0 5047.3 10291.7 10291.8 10292.0 10323.6 10358.4 5562.4 5574.8 5576.9 5598.4 5606.0 4994.9 5005.8 5078.4 5082.0 5096.1 3991.8 4003.0 4016.5 4035.8 4053.1 1090.7 1285.8 1330.9 1340.3 1358.6 1128.7 1134.7 1151.1 1325.5 1397.7 7963.1 8010.6 8041.0 8086.6 8091.3 1168.5 1174.7 1188.5 1197.4 1215.3 6201.2 6211.4 6236.0 6249.4 6303.0 10532.8 10689.9 10715.1 10839.9 10875.2 9548.3 9892.6 10222.4 10710.6 10726.5 8289.2 8315.2 8344.5 8357.0 8400.2 6808.2 7972.7 8028.9 8031.4 8253.5 9664.2 9904.8 9918.0 9972.8 10026.7 10000.4 10137.6 10152.7 10161.8 10262.7 7475.9 7493.7 7586.8 7668.9 7686.4 8143.8 8227.5 8245.5 8274.0 8342.7 6220.8 6929.4 7539.2 7559.7 7691.3 7107.2 7232.6 7242.1 7254.4 7288.9 7857.0 7876.3 7901.6 7916.6 7932.5 7043.8 7120.8 7174.1 7180.0 7181.6 6170.6 7170.0 7196.9 7241.8 7315.5 04:41:10 INFO - PROCESS | 7132 | 04:41:10 INFO - PROCESS | 7132 | [#4] prototype.html Cycles:180 Average:5948.24 Median:6761.69 stddev:1980.06 (29.3%) stddev-sans-first:1939.44 04:41:10 INFO - PROCESS | 7132 | Values: 284.4 288.2 335.3 339.9 342.7 6763.3 6789.7 6827.3 7024.3 7059.2 5972.4 6820.1 6912.8 6952.8 7004.6 4528.5 4742.7 4987.4 5017.6 5020.9 4997.4 5002.5 5005.4 5032.6 5038.2 4927.9 4960.4 4961.1 4965.1 4974.7 4678.2 4895.8 4957.4 4959.0 4962.8 4117.1 4117.7 4118.4 4134.4 4148.6 6436.5 6438.2 6502.8 6507.4 6567.0 4707.7 4760.5 5608.7 5848.0 5862.3 5866.9 7212.2 7218.1 7233.7 7261.1 4663.9 4676.3 4678.3 4679.6 4686.1 7665.2 7748.8 7750.3 7776.9 7784.7 4000.8 4577.6 4662.1 4673.7 4743.7 4799.9 4827.3 4827.8 4828.5 4850.5 4716.9 5836.3 5839.2 5857.9 5864.8 7351.5 7354.2 7361.3 7388.2 7391.0 1377.4 1647.4 1674.7 1684.3 1690.2 866.4 987.5 994.5 1038.2 1057.7 5736.5 6719.0 6728.8 6739.4 6760.1 6120.0 7588.5 7596.7 7604.5 7670.5 5450.6 6741.5 6743.8 6748.4 6758.3 3421.3 3995.7 3996.6 4000.3 4019.4 7806.6 8034.9 8075.5 8083.9 8098.1 7985.8 7995.1 8000.9 8007.9 8017.1 8015.9 8051.3 8069.8 8070.8 8092.3 7454.6 7696.4 7713.0 7723.7 7771.8 7540.4 7552.2 7558.3 7570.4 7585.2 8010.8 8014.6 8030.2 8043.6 8047.2 4781.5 4813.7 4827.4 4827.9 4839.9 7354.0 7688.9 7712.8 7739.5 7745.5 7321.5 7376.4 7395.9 7397.0 7437.8 7373.9 7385.6 7393.7 7395.3 7399.9 7205.6 7210.5 7211.1 7214.9 7232.8 7101.6 7321.5 7336.6 7359.7 7369.4 5799.4 6953.2 7133.5 7139.6 7146.4 04:41:10 INFO - PROCESS | 7132 | 04:41:10 INFO - PROCESS | 7132 | [#5] yui.html Cycles:180 Average:18249.38 Median:640.89 stddev:25703.23 (4010.5%) stddev-sans-first:25741.30 04:41:10 INFO - PROCESS | 7132 | Values: 634.9 646.9 670.1 671.3 693.4 12831.2 14688.9 14853.8 14935.6 15009.4 12938.8 14165.0 14316.4 14330.5 14367.5 705.0 853.4 862.4 872.3 873.0 769.6 849.5 864.8 868.8 872.1 891.5 914.1 916.3 923.3 927.8 879.0 898.7 912.6 913.8 914.0 658.5 667.6 676.8 677.1 681.4 14777.7 14797.5 14818.6 14845.3 14892.3 13124.7 13206.2 13223.3 13263.0 13334.8 9753.1 10171.1 10241.7 10501.3 10848.9 3140.8 3533.4 3575.8 3605.9 3713.6 62636.0 84605.7 84735.7 84864.0 87013.6 9362.9 9473.1 9531.5 9641.6 9910.4 17644.6 20782.4 20904.0 20909.6 21592.0 7377.8 7402.3 7471.4 7552.0 7663.3 3984.9 3994.2 4021.1 4049.2 4147.3 3589.4 3608.4 3616.7 3635.4 3640.5 670.7 672.1 672.4 680.3 682.2 539.6 548.2 581.0 605.0 620.4 8154.8 8305.6 8434.8 8527.0 8714.3 493.1 544.5 564.5 585.5 591.5 4004.3 4030.7 4032.8 4054.9 4087.8 90218.0 91725.0 97073.5 98073.0 98268.0 71618.0 72268.6 72559.3 73205.0 74225.6 66896.3 67085.7 68369.6 70917.3 71962.0 7869.4 8712.6 8790.0 8886.5 9045.2 47804.0 48971.0 49472.8 50419.7 52132.0 68936.3 69297.3 70227.0 70530.6 71495.0 10977.7 11129.7 11306.5 11349.7 11767.6 10840.0 11636.2 11959.6 12629.2 12736.2 11477.7 11527.0 11729.6 11875.0 11889.2 9901.5 10799.7 10809.6 11687.7 11904.3 11302.7 11650.4 11792.5 11806.9 12299.8 8172.9 9303.9 9411.0 9449.8 10054.2 7871.1 9086.4 9199.6 9842.2 9931.7 04:41:10 INFO - PROCESS | 7132 | -------- Summary: end -------- 04:41:10 INFO - PROCESS | 7132 | 04:41:10 INFO - TEST-INFO | 7132: exit 0 04:41:10 INFO - TEST-OK | dromaeo_css | took 1111827ms 04:41:10 INFO - TEST-START | kraken 04:41:10 INFO - operating with platform_type : mac_ 04:41:10 INFO - Initialising browser for kraken test... 04:41:10 INFO - TEST-INFO | started process 7139 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmp0UIl0N/profile http://localhost:58697/getInfo.html) 04:41:13 INFO - PROCESS | 7139 | __metrics Screen width/height:1600/1200 04:41:13 INFO - PROCESS | 7139 | colorDepth:24 04:41:13 INFO - PROCESS | 7139 | Browser inner width/height: 1024/689 04:41:13 INFO - PROCESS | 7139 | __metrics 04:41:13 ERROR - PROCESS | 7139 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 04:41:13 INFO - TEST-INFO | 7139: exit 0 04:41:13 INFO - Browser initialized. 04:41:13 INFO - Running cycle 1/1 for kraken test... 04:41:13 INFO - TEST-INFO | started process 7142 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmp0UIl0N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:41:26 INFO - PROCESS | 7142 | RSS: Main: 255623168 04:41:26 INFO - PROCESS | 7142 | 04:41:28 INFO - PROCESS | 7142 | Cycle 1(1): loaded http://localhost:58697/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58697/tests/kraken/driver.html?testName=audio-beat-detection) 04:41:29 INFO - PROCESS | 7142 | RSS: Main: 268808192 04:41:29 INFO - PROCESS | 7142 | 04:41:32 INFO - PROCESS | 7142 | Cycle 1(1): loaded http://localhost:58697/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58697/tests/kraken/driver.html?testName=audio-dft) 04:41:32 INFO - PROCESS | 7142 | RSS: Main: 276647936 04:41:32 INFO - PROCESS | 7142 | 04:41:36 INFO - PROCESS | 7142 | Cycle 1(1): loaded http://localhost:58697/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58697/tests/kraken/driver.html?testName=audio-fft) 04:41:36 INFO - PROCESS | 7142 | RSS: Main: 280911872 04:41:36 INFO - PROCESS | 7142 | 04:41:38 INFO - PROCESS | 7142 | Cycle 1(1): loaded http://localhost:58697/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58697/tests/kraken/driver.html?testName=audio-oscillator) 04:41:39 INFO - PROCESS | 7142 | RSS: Main: 281440256 04:41:39 INFO - PROCESS | 7142 | 04:41:41 INFO - PROCESS | 7142 | Cycle 1(1): loaded http://localhost:58697/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58697/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:41:41 INFO - PROCESS | 7142 | RSS: Main: 282128384 04:41:41 INFO - PROCESS | 7142 | 04:41:44 INFO - PROCESS | 7142 | Cycle 1(1): loaded http://localhost:58697/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58697/tests/kraken/driver.html?testName=imaging-darkroom) 04:41:45 INFO - PROCESS | 7142 | RSS: Main: 282120192 04:41:45 INFO - PROCESS | 7142 | 04:41:48 INFO - PROCESS | 7142 | Cycle 1(1): loaded http://localhost:58697/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58697/tests/kraken/driver.html?testName=imaging-desaturate) 04:41:48 INFO - PROCESS | 7142 | RSS: Main: 282087424 04:41:48 INFO - PROCESS | 7142 | 04:41:51 INFO - PROCESS | 7142 | Cycle 1(1): loaded http://localhost:58697/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58697/tests/kraken/driver.html?testName=json-parse-financial) 04:41:52 INFO - PROCESS | 7142 | RSS: Main: 283672576 04:41:52 INFO - PROCESS | 7142 | 04:41:53 INFO - PROCESS | 7142 | Cycle 1(1): loaded http://localhost:58697/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58697/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:41:54 INFO - PROCESS | 7142 | RSS: Main: 282923008 04:41:54 INFO - PROCESS | 7142 | 04:41:56 INFO - PROCESS | 7142 | Cycle 1(1): loaded http://localhost:58697/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58697/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:41:57 INFO - PROCESS | 7142 | RSS: Main: 282906624 04:41:57 INFO - PROCESS | 7142 | 04:41:59 INFO - PROCESS | 7142 | Cycle 1(1): loaded http://localhost:58697/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58697/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:41:59 INFO - PROCESS | 7142 | RSS: Main: 283254784 04:41:59 INFO - PROCESS | 7142 | 04:42:02 INFO - PROCESS | 7142 | Cycle 1(1): loaded http://localhost:58697/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:42:03 INFO - PROCESS | 7142 | RSS: Main: 282259456 04:42:03 INFO - PROCESS | 7142 | 04:42:05 INFO - PROCESS | 7142 | Cycle 1(1): loaded http://localhost:58697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:42:06 INFO - PROCESS | 7142 | RSS: Main: 283680768 04:42:06 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | Cycle 1(1): loaded http://localhost:58697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58697/tests/kraken/driver.html?testName=ai-astar) 04:42:08 INFO - PROCESS | 7142 | RSS: Main: 285396992 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | __start_tp_report 04:42:08 INFO - PROCESS | 7142 | _x_x_mozilla_page_load 04:42:08 INFO - PROCESS | 7142 | _x_x_mozilla_page_load_details 04:42:08 INFO - PROCESS | 7142 | |i|pagename|runs| 04:42:08 INFO - PROCESS | 7142 | |0;ai-astar;113;109;116;115;122;176;119;129;99;132 04:42:08 INFO - PROCESS | 7142 | |1;audio-beat-detection;153;129;134;139;110;178;171;150;166;149 04:42:08 INFO - PROCESS | 7142 | |2;audio-dft;201;195;203;212;213;202;201;201;210;204 04:42:08 INFO - PROCESS | 7142 | |3;audio-fft;68;82;72;116;58;55;60;61;135;76 04:42:08 INFO - PROCESS | 7142 | |4;audio-oscillator;83;82;117;82;81;88;118;80;82;113 04:42:08 INFO - PROCESS | 7142 | |5;imaging-gaussian-blur;88;95;89;94;89;81;93;94;89;95 04:42:08 INFO - PROCESS | 7142 | |6;imaging-darkroom;104;127;148;119;97;125;149;98;102;96 04:42:08 INFO - PROCESS | 7142 | |7;imaging-desaturate;94;94;99;92;135;113;91;94;91;92 04:42:08 INFO - PROCESS | 7142 | |8;json-parse-financial;55;58;57;56;57;58;55;68;85;82 04:42:08 INFO - PROCESS | 7142 | |9;json-stringify-tinderbox;74;83;54;66;78;106;101;95;70;66 04:42:08 INFO - PROCESS | 7142 | |10;stanford-crypto-aes;86;85;86;87;85;86;84;90;90;86 04:42:08 INFO - PROCESS | 7142 | |11;stanford-crypto-ccm;151;130;155;136;139;142;138;119;122;124 04:42:08 INFO - PROCESS | 7142 | |12;stanford-crypto-pbkdf2;132;140;149;139;130;142;148;183;179;158 04:42:08 INFO - PROCESS | 7142 | |13;stanford-crypto-sha256-iterative;67;72;89;92;79;70;67;69;70;67 04:42:08 INFO - PROCESS | 7142 | __end_tp_report 04:42:08 INFO - PROCESS | 7142 | __start_cc_report 04:42:08 INFO - PROCESS | 7142 | _x_x_mozilla_cycle_collect,913 04:42:08 INFO - PROCESS | 7142 | __end_cc_report 04:42:08 INFO - PROCESS | 7142 | __startTimestamp1456144928342__endTimestamp 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | ------- Summary: start ------- 04:42:08 INFO - PROCESS | 7142 | Number of tests: 14 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | [#0] ai-astar Cycles:10 Average:123.00 Median:125.50 stddev:20.89 (16.6%) stddev-sans-first:21.84 04:42:08 INFO - PROCESS | 7142 | Values: 113.0 109.0 116.0 115.0 122.0 176.0 119.0 129.0 99.0 132.0 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:151.50 stddev:20.72 (13.7%) stddev-sans-first:21.90 04:42:08 INFO - PROCESS | 7142 | Values: 153.0 129.0 134.0 139.0 110.0 178.0 171.0 150.0 166.0 149.0 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | [#2] audio-dft Cycles:10 Average:204.20 Median:203.50 stddev:5.71 (2.8%) stddev-sans-first:5.94 04:42:08 INFO - PROCESS | 7142 | Values: 201.0 195.0 203.0 212.0 213.0 202.0 201.0 201.0 210.0 204.0 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | [#3] audio-fft Cycles:10 Average:78.30 Median:64.50 stddev:26.65 (41.3%) stddev-sans-first:28.00 04:42:08 INFO - PROCESS | 7142 | Values: 68.0 82.0 72.0 116.0 58.0 55.0 60.0 61.0 135.0 76.0 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:82.00 stddev:16.33 (19.9%) stddev-sans-first:16.95 04:42:08 INFO - PROCESS | 7142 | Values: 83.0 82.0 117.0 82.0 81.0 88.0 118.0 80.0 82.0 113.0 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:93.50 stddev:4.40 (4.7%) stddev-sans-first:4.56 04:42:08 INFO - PROCESS | 7142 | Values: 88.0 95.0 89.0 94.0 89.0 81.0 93.0 94.0 89.0 95.0 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | [#6] imaging-darkroom Cycles:10 Average:116.50 Median:148.50 stddev:20.40 (13.7%) stddev-sans-first:21.13 04:42:08 INFO - PROCESS | 7142 | Values: 104.0 127.0 148.0 119.0 97.0 125.0 149.0 98.0 102.0 96.0 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | [#7] imaging-desaturate Cycles:10 Average:99.50 Median:93.00 stddev:14.10 (15.2%) stddev-sans-first:14.82 04:42:08 INFO - PROCESS | 7142 | Values: 94.0 94.0 99.0 92.0 135.0 113.0 91.0 94.0 91.0 92.0 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:58.00 stddev:11.40 (19.6%) stddev-sans-first:11.70 04:42:08 INFO - PROCESS | 7142 | Values: 55.0 58.0 57.0 56.0 57.0 58.0 55.0 68.0 85.0 82.0 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | [#9] json-stringify-tinderbox Cycles:10 Average:79.30 Median:72.00 stddev:16.85 (23.4%) stddev-sans-first:17.76 04:42:08 INFO - PROCESS | 7142 | Values: 74.0 83.0 54.0 66.0 78.0 106.0 101.0 95.0 70.0 66.0 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:2.01 (2.3%) stddev-sans-first:2.13 04:42:08 INFO - PROCESS | 7142 | Values: 86.0 85.0 86.0 87.0 85.0 86.0 84.0 90.0 90.0 86.0 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:138.50 stddev:12.01 (8.7%) stddev-sans-first:11.37 04:42:08 INFO - PROCESS | 7142 | Values: 151.0 130.0 155.0 136.0 139.0 142.0 138.0 119.0 122.0 124.0 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.00 Median:148.50 stddev:18.28 (12.3%) stddev-sans-first:18.19 04:42:08 INFO - PROCESS | 7142 | Values: 132.0 140.0 149.0 139.0 130.0 142.0 148.0 183.0 179.0 158.0 04:42:08 INFO - PROCESS | 7142 | 04:42:08 INFO - PROCESS | 7142 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:71.00 stddev:9.32 (13.1%) stddev-sans-first:9.51 04:42:08 INFO - PROCESS | 7142 | Values: 67.0 72.0 89.0 92.0 79.0 70.0 67.0 69.0 70.0 67.0 04:42:08 INFO - PROCESS | 7142 | -------- Summary: end -------- 04:42:08 INFO - PROCESS | 7142 | 04:42:09 INFO - TEST-INFO | 7142: exit 0 04:42:09 INFO - TEST-OK | kraken | took 58461ms 04:42:09 INFO - SUITE-END | took 1170s 04:42:09 INFO - Completed test suite (00:19:30) 04:42:09 INFO - Working with test: dromaeo_css 04:42:09 INFO - Generating results file: dromaeo_css 04:42:09 INFO - Working with test: kraken 04:42:09 INFO - Generating results file: kraken 04:42:09 INFO - javascript benchmark 04:42:09 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:42:09 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 04:42:09 INFO - process_Request line: dromaeo_css 7682.71 graph.html#tests=[[72,64,61]] 04:42:09 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:42:09 INFO - process_Request line: kraken 1541.40 graph.html#tests=[[232,64,61]] 04:42:09 INFO - RETURN: dromaeo_css: 7682.71 04:42:09 INFO - RETURN: kraken: 1541.40 04:42:09 INFO - javascript benchmark 04:42:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3452.0506860613336, 3470.167159881626, 3474.200933785228, 3536.5579302587175, 3538.823058847058, 5000.824971126011, 5115.258287548303, 5753.5109515691165, 5763.740631671574, 5765.279340082489, 5613.80351687691, 5753.626014309067, 5784.450477204669, 5867.853303667411, 5889.911651325234, 5153.458886816896, 5178.404483484391, 5189.0, 5206.167013277876, 5261.789528418859, 5231.26762253283, 5266.683998960056, 5267.051930652481, 5272.393674727398, 5299.0, 4956.776945037446, 5051.64638475305, 5113.488651134894, 5199.974000129975, 5210.088234558937, 5189.351331083614, 5209.661372010807, 5229.947700522984, 5247.449017853147, 5297.814576489843, 3985.9437249129005, 5144.639875208737, 5206.479352064801, 5228.947710522884, 5231.372235331746, 5542.86142846428, 5655.434456554352, 5684.204211410406, 5693.658380497183, 5700.116481945305, 6243.250809902841, 6314.684265786738, 6316.494680425555, 6326.557141000132, 6335.081413195061, 6213.502919766408, 6218.067289906505, 6251.906221406637, 6295.842603934938, 6299.65351905645, 5845.883082338372, 5885.0, 5920.644761314335, 5949.643021418642, 5992.34084250732, 6217.658028808459, 6287.151234583364, 6287.685615719287, 6294.370562943669, 6296.811095667137, 6118.040554665137, 6222.657753823492, 6240.219972503437, 6246.250449945945, 6254.999200128049, 6202.596831205957, 6237.0, 6308.337624549448, 6331.018692102732, 6340.4293613575, 4864.513548645107, 6207.068939659087, 6252.3122456529745, 6290.559660823698, 6320.209973753281, 6267.843303917439, 6273.560850740404, 6291.622502649856, 6298.212723409574, 6319.115323854664, 4902.0441014002645, 4944.085344211332, 4950.925736113961, 4955.653104282737, 4963.181075122637, 4322.502912165079, 4394.560543945579, 4397.6042156206095, 4441.822327106945, 4486.528914463935, 5734.6845923473775, 5754.539636829128, 5759.280089988752, 5808.419158084243, 5809.50619197373, 5094.64478255661, 6213.03697926813, 6246.625202487865, 6263.279722831841, 6299.6850157491945, 5759.539236861041, 5763.538916886639, 5800.071988481823, 5817.680027598438, 5852.063669812809, 5404.297441332602, 5416.295881535454, 5435.402105768362, 5441.6190866639745, 5456.536194423518, 6236.968815155895, 6304.6847657617855, 6347.96826015867, 6422.389872962061, 6431.0, 4996.500349964975, 5851.268591426072, 6220.657863817533, 6261.405166509175, 6287.842803929755, 6362.522810789302, 6397.104405383157, 6401.039844023434, 6410.102585637921, 6420.454261387835, 6094.603850749687, 6191.102290167991, 6312.5581209314905, 6314.6842657866, 6332.145160403286, 6203.503719702323, 6217.782377616762, 6260.248770147611, 6265.467435268053, 6279.0, 5276.709780962084, 6074.331823499323, 6160.630362178284, 6246.562740608114, 6247.0, 5305.779670675689, 6126.945200426759, 6182.629042257479, 6230.470410015199, 6243.37566243372, 5245.0, 5944.702764861653, 5971.0744834550715, 6010.3088144863905, 6106.938930610815, 5927.140564618193, 6135.478484328882, 6245.687715614292, 6251.78118765841, 6265.028920517327, 6095.299040610386, 6137.508999279958, 6149.323574406722, 6157.9384206157365, 6174.845628859135], "unit": "score", "name": "dojo.html", "value": 5700.1446577555935}, {"lowerIsBetter": false, "replicates": [438.4672622763344, 453.58496975267633, 486.47946697034166, 521.9034478621455, 593.6883136353416, 29484.410311793752, 38185.809070954674, 38251.61748382515, 38279.61720382799, 38393.42409863854, 39943.400848987214, 40529.0, 40558.79720601393, 40606.18787624246, 40607.78176654705, 9368.57841397137, 9525.095115963972, 9549.379290346105, 9576.760580985461, 9621.759456013586, 9377.202937750299, 9578.952105239465, 9604.807903841918, 9638.807223855518, 9654.227661787076, 9576.569054392534, 9589.18491928187, 9638.180754635865, 9671.274654400948, 9673.032696730306, 9561.28290378221, 9572.377795443308, 9617.134457898752, 9620.903790962106, 9624.085711857362, 9515.381500202464, 9625.085616866387, 9691.030896910323, 9697.806043879153, 9725.221982241404, 38270.80864595659, 38381.232375352614, 38463.615363846286, 38606.8417947462, 38684.806575967224, 2887.5524293734293, 3279.6392396836327, 3347.6484969078138, 3424.2637832865803, 3640.672339489459, 27103.728962710316, 27563.586546201823, 27729.722702772917, 28026.579601305995, 28299.717002829915, 2742.0, 2763.5163846327014, 2786.1084452975056, 2805.6633204015443, 2842.3888863894153, 366547.0, 423758.0, 427251.0, 432016.99999999686, 435010.0, 45889.31166032512, 46508.0, 46561.5343846564, 47379.289310660366, 65351.346486535476, 31442.685573144434, 41397.79301103475, 45349.773251133534, 45568.3164752529, 45669.771651141535, 15219.010764300285, 15270.236488175547, 15296.694066118615, 15375.461858834888, 15514.224288785515, 12151.696207594881, 12262.141650084408, 12332.075094367958, 12334.81497777534, 12460.563880264148, 14603.634909127144, 14645.828333733276, 14668.413263469554, 14682.265886705622, 14724.0, 6252.3122456529745, 6360.459360954371, 6386.552941294065, 6395.20059992501, 6404.967975160094, 774.71722821171, 982.9852552211722, 1018.7198520406799, 1097.8023955688052, 1186.810110382352, 25602.615960760602, 29336.706632933823, 30341.24146896301, 30344.0, 30397.392052158833, 945.721012301359, 1084.414416215235, 1099.7792450380073, 1114.8383484394878, 1167.5971789732528, 11680.474378652982, 14561.466642675927, 14614.561563153122, 14893.553193404216, 15092.698146037017, 580089.0, 598315.0, 651866.0, 674620.0, 675787.0, 57933.710331448914, 57946.13080803792, 58246.41753582495, 58311.0, 59018.0, 1433.978490322646, 1497.423491955605, 1497.490853109948, 1501.3018946190075, 1506.4200282891165, 28943.0, 29075.273118172216, 29113.126606201848, 29300.0, 29724.851375742983, 49367.7531612354, 50043.49956500388, 50191.745206370135, 50687.98624027425, 50724.0, 487598.0, 490000.0, 491402.0, 493659.0, 495389.0, 33155.0, 33937.0, 34275.65724342824, 34430.311393772485, 34616.30767384689, 44310.55689443064, 45775.542244577126, 46166.53833461623, 46229.0, 46229.76885115553, 27899.721002789713, 30481.390372192876, 35734.0, 38136.0, 38728.80635596804, 36805.26389472249, 36899.81550092233, 37822.81088594539, 37960.240795184494, 37961.62038379581, 36784.44823327599, 37140.0, 37471.06322341963, 37502.0, 37783.43324850075, 25277.87361063183, 29279.85360073186, 30195.4902254882, 34095.31809363848, 34899.65100349065, 18835.529111771768, 20696.846464375696, 24224.75775242225, 25095.117866159744, 25643.358916026504], "unit": "score", "name": "ext.html", "value": 18885.368112676548}, {"lowerIsBetter": false, "replicates": [324.4597744754983, 327.9737620990321, 343.34935297611014, 351.9630438803927, 357.2747322934444, 15700.528984130495, 19283.132259048358, 19549.315773947914, 19798.802011979875, 19934.0, 19862.0, 20120.39638810838, 21134.15463381467, 21824.563508729814, 21865.0, 4682.765861706901, 6335.239771227459, 6589.143411356529, 6645.734170633169, 6652.368025037614, 7226.458015648821, 7594.240575942416, 7601.3538849197885, 7606.125295590995, 7626.809329766745, 6930.826729331782, 7193.460490463236, 7249.637518124099, 7551.735689250877, 7553.24467553243, 6597.835054123685, 6885.173779146509, 7152.070230869979, 7205.67574459148, 7575.0, 7201.531900426456, 7208.747693830744, 7212.206657267697, 7213.783586492414, 7221.530600511002, 26171.0, 27119.593206101923, 27130.1860944172, 27189.45621087587, 27784.58323125155, 2198.758136604972, 2254.6730724045087, 2315.502167034079, 2350.659154422599, 2975.4792911240447, 13263.204207747469, 14913.03065300752, 15257.0, 15545.378184872592, 15603.609909752233, 1578.6132397562556, 1837.9632407351778, 1874.3533480949052, 1886.56608979934, 1896.421591414618, 70652.6467367665, 114253.99999999917, 115260.0, 115724.05655660602, 116176.0, 19262.518437038907, 19880.50298742514, 20007.799922000886, 20070.89964550168, 20089.296874609612, 28877.0, 28966.42067158645, 29301.413971720445, 29314.82740690391, 29329.413411731646, 10632.681019569425, 10790.406527641055, 10811.513481893333, 10860.782784344268, 10882.836757448644, 7412.221716719775, 7944.682212711542, 8785.209331160226, 9097.77255568616, 9258.90741092594, 6194.5354098442795, 7324.194338622748, 8251.133630968781, 8604.225619694258, 8710.651573936972, 3465.5841299043773, 3549.254656522108, 3553.6446355364255, 3554.1211618589027, 3696.2607478504406, 812.8333691593209, 914.350810924238, 929.8837645294338, 977.9511024448749, 1047.298310132198, 19035.0, 19471.4158575243, 19962.20151193965, 20700.0, 21463.57072858565, 783.9608019598998, 946.1059298962552, 972.2999440402899, 972.8103019911049, 1051.805415998043, 11047.934146269039, 11443.656690299304, 11495.310281383145, 11617.244879082833, 11688.532458701728, 547386.0, 669945.0, 678078.0, 679266.0, 685176.5741171262, 117583.41208293904, 121995.0, 123685.0, 124096.37951810184, 128893.0, 1023.6928921323573, 1028.7890982348601, 1043.1498328862106, 1044.5038606661774, 1049.821530339844, 18261.90869045646, 18379.26482940721, 18551.90724046371, 18559.979201144066, 18852.34016809405, 50814.23778643397, 51724.74137629288, 55462.168067479826, 55957.0, 60818.695906521956, 61287.0, 74333.62833186016, 78138.0, 80603.0, 86009.0, 11522.942385288019, 11935.462904169159, 12072.215306005082, 12245.571405000783, 12309.692257693629, 9139.954300228455, 9162.404443711137, 9346.485943273185, 12207.938960305142, 14159.787603186167, 6310.49516038725, 7099.396551292992, 8277.710280140167, 8308.958455207685, 8619.82760344802, 7346.265373462611, 7942.6028698566, 8138.186181381814, 8367.288780453486, 8369.163083691583, 8482.066972632882, 8505.319574433906, 8544.273736732448, 8565.528895910535, 8617.569121544024, 11916.821247681119, 12015.339156346135, 12284.754304914031, 12304.507819687113, 12389.194702344319, 10102.595896164072, 10211.591536338761, 12075.51697932073, 12085.093617978511, 12191.0], "unit": "score", "name": "jquery.html", "value": 10603.009878381337}, {"lowerIsBetter": false, "replicates": [1475.6089636246393, 1480.9703805923882, 1705.4968784208656, 1881.1064744246476, 1887.3582981786199, 8083.595820208995, 8623.655053797856, 8753.080926502713, 8890.466572005676, 8953.104689531052, 8594.398392112555, 8612.526311052905, 8647.178518040777, 8750.343724220693, 8759.167879051496, 2484.987575062127, 2488.688913885764, 2512.811539134563, 2513.49730053989, 2514.120057979711, 2467.1734968785477, 2521.2688320387065, 2527.5576774064466, 2528.40582463121, 2538.1370334086405, 2187.3547303545492, 2433.0875921529428, 2475.653408522808, 2498.600223964166, 2508.9372765680914, 2455.2143314139485, 2456.9262922112184, 2464.8521088734733, 2484.689413823272, 2500.824942254034, 2444.2667199840153, 2468.148488771371, 2470.0737223541173, 2485.9129930452527, 2495.1142344467635, 8602.483850968962, 8692.261157801595, 8739.563021848882, 8752.47485150893, 8758.912410875873, 5413.458654134594, 5580.38615752271, 5581.832545023615, 5595.468430499096, 5604.579656525777, 3670.541182352206, 3689.4834723138783, 3692.3169213695282, 3821.14024344523, 3839.520059992501, 1053.984190237147, 1060.0247772049734, 1068.417712346765, 1102.0, 1102.1127991966464, 11865.82201266973, 11975.760484790255, 12015.219010764273, 12062.155649104567, 12065.095117866107, 4157.563455837154, 4946.950530494721, 5024.824131155392, 5030.0191462664425, 5047.268146118792, 10291.691249262534, 10291.794164116676, 10292.0, 10323.587056517805, 10358.378497290187, 5562.360328562187, 5574.804881829116, 5576.860578485489, 5598.384177740445, 5606.0, 4994.90010199794, 5005.7997680092385, 5078.415982162099, 5081.9745901271, 5096.0827051131155, 3991.84032638697, 4003.0, 4016.5180178378196, 4035.8385664573675, 4053.0880551875593, 1090.7436752363346, 1285.8264134341932, 1330.8735670111323, 1340.3298350824587, 1358.6060042587737, 1128.7347473343757, 1134.65393055119, 1151.073385924339, 1325.4631874091008, 1397.6645605054916, 7963.124056353797, 8010.5994700264755, 8041.0, 8086.636101375452, 8091.271785539329, 1168.5384273212035, 1174.6945794093597, 1188.5008296515484, 1197.4312201704122, 1215.3437143942172, 6201.193844800147, 6211.378862113843, 6236.03341482071, 6249.375062493714, 6303.023031430135, 10532.789344213073, 10689.9465502672, 10715.089217416607, 10839.891601083888, 10875.238733288752, 9548.331616786898, 9892.604295828087, 10222.437765922798, 10710.625128120635, 10726.517306721216, 8289.171082891784, 8315.210055044761, 8344.499330040095, 8357.0, 8400.243978042006, 6808.206745718787, 7972.681092756225, 8028.879566806386, 8031.357491400557, 8253.504789712637, 9664.226861850895, 9904.752381190528, 9917.958614345389, 9972.800543988935, 10026.69919902404, 10000.399976001463, 10137.594496220068, 10152.695419137437, 10161.847572286273, 10262.743431414274, 7475.850482990419, 7493.662785174572, 7586.810329741801, 7668.884966725392, 7686.423518236043, 8143.75568732939, 8227.465214761261, 8245.546494942835, 8274.0, 8342.666293348198, 6220.813375598739, 6929.376356127973, 7539.246075392417, 7559.735409260649, 7691.30778229962, 7107.18267399235, 7232.566046037255, 7242.094738157731, 7254.383377412768, 7288.890666640111, 7856.960715196387, 7876.330511906552, 7901.604919754104, 7916.643751031333, 7932.484388514728, 7043.7534686285735, 7120.750773722895, 7174.067371241914, 7180.0, 7181.605011724405, 6170.629762214281, 7170.0, 7196.856062878608, 7241.782746517613, 7315.451341149329], "unit": "score", "name": "mootools.html", "value": 4990.290410006765}, {"lowerIsBetter": false, "replicates": [284.38572683004713, 288.20455542702143, 335.2774770369853, 339.9048266485385, 342.6607658418165, 6763.256041835407, 6789.66051697415, 6827.31726827317, 7024.26245244249, 7059.1529016518025, 5972.432618901208, 6820.147481564804, 6912.8271793205195, 6952.756653517128, 7004.614746188958, 4528.50186479487, 4742.668013239075, 4987.376577927759, 5017.64876458648, 5020.924686129692, 4997.4003119625695, 5002.549770520653, 5005.374328208974, 5032.572231360339, 5038.1687021641565, 4927.876803079916, 4960.429550601672, 4961.107000739883, 4965.0814599299065, 4974.726390048546, 4678.204705200124, 4895.804167833282, 4957.405111386621, 4958.983408401287, 4962.826301079463, 4117.07365842686, 4117.732347397409, 4118.373242569169, 4134.37984302354, 4148.647364973981, 6436.452901503378, 6438.195225596801, 6502.772402965921, 6507.44686701631, 6567.0, 4707.693999890031, 4760.547747963972, 5608.691521966291, 5848.0, 5862.296524417055, 5866.853328666774, 7212.206657267697, 7218.061651985261, 7233.710651573931, 7261.128664560234, 4663.930041049387, 4676.251799712029, 4678.251479763256, 4679.578837904605, 4686.08621318843, 7665.156832748393, 7748.806279842993, 7750.302472777477, 7776.883346749803, 7784.688612455495, 4000.839756470591, 4577.6453878324155, 4662.090892275974, 4673.719576825333, 4743.739094349844, 4799.856004319876, 4827.275908613736, 4827.806887724522, 4828.46886842447, 4850.466448690641, 4716.88207794801, 5836.270466191726, 5839.153322768175, 5857.88284234313, 5864.824055278264, 7351.4853960223345, 7354.154272258758, 7361.337479626753, 7388.224236455095, 7391.0, 1377.4008306386754, 1647.3739978808217, 1674.7487876818575, 1684.292597109217, 1690.163369132263, 866.3545658484344, 987.4963768477984, 994.5077186792583, 1038.1694644284541, 1057.7408534908996, 5736.541076713853, 6719.0, 6728.831779205461, 6739.393454589012, 6760.121184246016, 6120.0, 7588.544687318778, 7596.658150383246, 7604.505707129019, 7670.463067585216, 5450.591205659592, 6741.494387920828, 6743.763968261087, 6748.392644662004, 6758.256591774901, 3421.2815308784934, 3995.72029957906, 3996.640302372742, 4000.319945609195, 4019.41718450823, 7806.60412720457, 8034.919650803534, 8075.475094118863, 8083.878741818878, 8098.068722097034, 7985.800354991055, 7995.080565734898, 8000.8799868002025, 8007.919920800718, 8017.118117007125, 8015.877777111209, 8051.315638170704, 8069.798255043554, 8070.757877263574, 8092.312153467021, 7454.58999754997, 7696.422768292512, 7712.997310349619, 7723.691052357843, 7771.805704857197, 7540.359069478936, 7552.207018263003, 7558.319751222197, 7570.394368450621, 7585.2035536267895, 8010.8397832041865, 8014.599270036591, 8030.156833532628, 8043.638036288498, 8047.1550487198, 4781.521847815191, 4813.687110337817, 4827.444843843003, 4827.903441931212, 4839.854804355875, 7353.963230183815, 7688.923110768821, 7712.768616941501, 7739.535627862347, 7745.496542724705, 7321.524100933422, 7376.4098872089035, 7395.889061664187, 7397.0, 7437.776866694008, 7373.852522949618, 7385.556866588022, 7393.704251829867, 7395.260473952561, 7399.852002960019, 7205.594908992696, 7210.531315464478, 7211.098612673416, 7214.855702886018, 7232.819179520554, 7101.573905565682, 7321.524100933422, 7336.559806411632, 7359.705611775469, 7369.410447164107, 5799.362070172362, 6953.235144134243, 7133.536320139175, 7139.607321597362, 7146.392556632536], "unit": "score", "name": "prototype.html", "value": 5269.535435562175}, {"lowerIsBetter": false, "replicates": [634.8984162533992, 646.8835609590271, 670.0652589637455, 671.3085521912426, 693.4140651149777, 12831.230126192411, 14688.853111468881, 14853.77719334208, 14935.626609334759, 15009.399624015039, 12938.805917911215, 14165.008449408546, 14316.427342906298, 14330.498432554836, 14367.49713760016, 704.989425158623, 853.3940901959617, 862.409249663979, 872.2890843962182, 872.9650813967434, 769.5613500304828, 849.4605925237488, 864.8270345930807, 868.8045189832301, 872.0668884293776, 891.5230351761809, 914.1133100892124, 916.3448134583771, 923.2890674180877, 927.7819712367589, 878.9912100879005, 898.6540182029933, 912.5847739278646, 913.7532866126109, 913.9725808225763, 658.4633523678187, 667.559410788877, 676.8104930619385, 677.1366507702669, 681.3901558105467, 14777.70444591113, 14797.482088126972, 14818.629534261621, 14845.257737113101, 14892.329845156994, 13124.737505249841, 13206.207627542282, 13223.338833058404, 13263.0, 13334.799978000337, 9753.122219000325, 10171.135453486462, 10241.743956401075, 10501.31741436804, 10848.891511084867, 3140.795848269878, 3533.3639944809925, 3575.767575107636, 3605.8557657693923, 3713.628637136265, 62636.0, 84605.73091403634, 84735.7289640656, 84864.0, 87013.56493217494, 9362.859557106649, 9473.147416732527, 9531.523423828781, 9641.566129524188, 9910.37641904006, 17644.647107057786, 20782.376528704164, 20904.0, 20909.581808363746, 21592.028358723896, 7377.77866664001, 7402.29678180572, 7471.3649339806725, 7551.962240188764, 7663.27198916102, 3984.940225896614, 3994.1612261425425, 4021.1354558770004, 4049.230646177217, 4147.253494370982, 3589.4077477215965, 3608.386574282378, 3616.65641764032, 3635.4365073413665, 3640.508531348234, 670.7216505150406, 672.1195234243157, 672.3847679373416, 680.2687111355214, 682.1984168601873, 539.5791282799423, 548.2078396716786, 580.9651420914759, 604.9516038716893, 620.3703241210176, 8154.75535733929, 8305.584720764058, 8434.789130271793, 8526.957365213135, 8714.259287960595, 493.12224240851344, 544.5235419008368, 564.478729823131, 585.5462016936908, 591.4765432592187, 4004.3192657248337, 4030.717849750489, 4032.778197199182, 4054.8986275343354, 4087.816048277835, 90218.0, 91725.0, 97073.51463242639, 98073.01926980639, 98268.0, 71618.0, 72268.55462890712, 72559.27440725631, 73205.0, 74225.6288718553, 66896.33103668998, 67085.66457167683, 68369.63260734758, 70917.29082709107, 71962.0, 7869.370450363843, 8712.564371781513, 8789.957189172092, 8886.511241881759, 9045.231155351605, 47804.043919122116, 48971.0, 49472.763180919326, 50419.747901260256, 52132.0, 68936.27659308357, 69297.30702692909, 70227.0, 70530.64734676294, 71495.0, 10977.725556861142, 11129.721756956142, 11306.4912078955, 11349.716257093638, 11767.646970590897, 10840.0, 11636.185467017227, 11959.581414650445, 12629.179103358252, 12736.23582585048, 11477.655670329903, 11527.0, 11729.648110556696, 11875.049996000473, 11889.167758256839, 9901.455419951972, 10799.730006749895, 10809.621663241749, 11687.707807304545, 11904.253576092495, 11302.660920172408, 11650.359230242419, 11792.52829886795, 11806.881931180922, 12299.75400492003, 8172.855800188097, 9303.906960930304, 9411.011843756307, 9449.811003780023, 10054.19566434698, 7871.094824095073, 9086.409383390059, 9199.632014719336, 9842.21262299, 9931.65239216624], "unit": "score", "name": "yui.html", "value": 6850.351701826001}], "name": "dromaeo_css", "value": 7682.7061124460715}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 116.0, 115.0, 122.0, 176.0, 119.0, 129.0, 99.0, 132.0], "unit": "score", "name": "ai-astar", "value": 123.0}, {"lowerIsBetter": true, "replicates": [153.0, 129.0, 134.0, 139.0, 110.0, 178.0, 171.0, 150.0, 166.0, 149.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [201.0, 195.0, 203.0, 212.0, 213.0, 202.0, 201.0, 201.0, 210.0, 204.0], "unit": "score", "name": "audio-dft", "value": 204.2}, {"lowerIsBetter": true, "replicates": [68.0, 82.0, 72.0, 116.0, 58.0, 55.0, 60.0, 61.0, 135.0, 76.0], "unit": "score", "name": "audio-fft", "value": 78.3}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 117.0, 82.0, 81.0, 88.0, 118.0, 80.0, 82.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 92.6}, {"lowerIsBetter": true, "replicates": [88.0, 95.0, 89.0, 94.0, 89.0, 81.0, 93.0, 94.0, 89.0, 95.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.7}, {"lowerIsBetter": true, "replicates": [104.0, 127.0, 148.0, 119.0, 97.0, 125.0, 149.0, 98.0, 102.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 116.5}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 99.0, 92.0, 135.0, 113.0, 91.0, 94.0, 91.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 99.5}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 57.0, 56.0, 57.0, 58.0, 55.0, 68.0, 85.0, 82.0], "unit": "score", "name": "json-parse-financial", "value": 63.1}, {"lowerIsBetter": true, "replicates": [74.0, 83.0, 54.0, 66.0, 78.0, 106.0, 101.0, 95.0, 70.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 79.3}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 86.0, 87.0, 85.0, 86.0, 84.0, 90.0, 90.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 155.0, 136.0, 139.0, 142.0, 138.0, 119.0, 122.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 135.6}, {"lowerIsBetter": true, "replicates": [132.0, 140.0, 149.0, 139.0, 130.0, 142.0, 148.0, 183.0, 179.0, 158.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.0}, {"lowerIsBetter": true, "replicates": [67.0, 72.0, 89.0, 92.0, 79.0, 70.0, 67.0, 69.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.2}], "name": "kraken", "value": 1541.4}]} 04:42:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1541.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7682.71"}}} 04:42:09 INFO - Return code: 0 04:42:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:42:10 ERROR - # TBPL SUCCESS # 04:42:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:42:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:42:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:42:10 INFO - 2016-02-22 04:42:10.065 screenresolution[7147:174566] starting screenresolution argv=screenresolution get 04:42:10 INFO - 2016-02-22 04:42:10.068 screenresolution[7147:174566] Display 0: 1600x1200x32@60 04:42:10 INFO - 2016-02-22 04:42:10.073 screenresolution[7148:174569] starting screenresolution argv=screenresolution list 04:42:10 INFO - Available Modes on Display 0 04:42:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:42:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:42:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:42:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:42:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:42:10 INFO - Intel Iris: 04:42:10 INFO - Chipset Model: Intel Iris 04:42:10 INFO - Type: GPU 04:42:10 INFO - Bus: Built-In 04:42:10 INFO - VRAM (Dynamic, Max): 1536 MB 04:42:10 INFO - Vendor: Intel (0x8086) 04:42:10 INFO - Device ID: 0x0a2e 04:42:10 INFO - Revision ID: 0x0009 04:42:10 INFO - Displays: 04:42:10 INFO - Display: 04:42:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:42:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:42:10 INFO - Display Serial Number: 1600x1200 60 04:42:10 INFO - Main Display: Yes 04:42:10 INFO - Mirror: Off 04:42:10 INFO - Online: Yes 04:42:10 INFO - Rotation: Supported 04:42:10 INFO - Return code: 0 04:42:10 INFO - Running post-action listener: _resource_record_post_action 04:42:10 INFO - Running post-run listener: _resource_record_post_run 04:42:11 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 0; Write bytes: 711030784; Read time: 0; Write time: 1903 04:42:11 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388719104; Write bytes: 383570944; Read time: 29724; Write time: 663 04:42:11 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 0; Write bytes: 304153600; Read time: 0; Write time: 1190 04:42:11 INFO - Running post-run listener: _upload_blobber_files 04:42:11 INFO - Blob upload gear active. 04:42:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:42:11 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 04:42:11 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'] 04:42:11 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 04:42:11 INFO - (blobuploader) - INFO - Open directory for files ... 04:42:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:42:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:42:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:12 INFO - (blobuploader) - INFO - Done attempting. 04:42:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:42:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:42:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:13 INFO - (blobuploader) - INFO - Done attempting. 04:42:13 INFO - (blobuploader) - INFO - Iteration through files over. 04:42:13 INFO - Return code: 0 04:42:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:42:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:42:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf62df42c59ac60f62c3ecfe58c030fe8ee5bf94d527e1554fe1f2e6b84cc8dd547668132ba769a28a175922fe7fdcd1d0cecaed856c8de46cf66a596a0f24d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f3b296d2b809ab95ca7dc84499e1e410ea0771a81892b323636d4d861d87be4d5734f10b8ddf33b88cbeec2e5f15f97172da150630e67b39e53666bc1682edd"} 04:42:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:42:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:42:13 INFO - Contents: 04:42:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf62df42c59ac60f62c3ecfe58c030fe8ee5bf94d527e1554fe1f2e6b84cc8dd547668132ba769a28a175922fe7fdcd1d0cecaed856c8de46cf66a596a0f24d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f3b296d2b809ab95ca7dc84499e1e410ea0771a81892b323636d4d861d87be4d5734f10b8ddf33b88cbeec2e5f15f97172da150630e67b39e53666bc1682edd"} 04:42:13 INFO - Running post-run listener: copy_logs_to_upload_dir 04:42:13 INFO - Copying logs to upload dir... 04:42:13 INFO - mkdir: /builds/slave/test/build/upload/logs 04:42:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.650278 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-02-22 04:42:13.906581) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 04:42:13.910353) ========= 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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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/cf62df42c59ac60f62c3ecfe58c030fe8ee5bf94d527e1554fe1f2e6b84cc8dd547668132ba769a28a175922fe7fdcd1d0cecaed856c8de46cf66a596a0f24d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f3b296d2b809ab95ca7dc84499e1e410ea0771a81892b323636d4d861d87be4d5734f10b8ddf33b88cbeec2e5f15f97172da150630e67b39e53666bc1682edd"} build_url:https://queue.taskcluster.net/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011569 build_url: 'https://queue.taskcluster.net/v1/task/GH_TgXlMQnSJ2-lUO7SAqw/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/cf62df42c59ac60f62c3ecfe58c030fe8ee5bf94d527e1554fe1f2e6b84cc8dd547668132ba769a28a175922fe7fdcd1d0cecaed856c8de46cf66a596a0f24d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f3b296d2b809ab95ca7dc84499e1e410ea0771a81892b323636d4d861d87be4d5734f10b8ddf33b88cbeec2e5f15f97172da150630e67b39e53666bc1682edd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 04:42:13.937793) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 04:42:13.938129) ========= 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.0kNd5Hi7Hh/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.ujFPYN20NN/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.005539 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 04:42:13.986913) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 04:42:13.987229) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 04:42:13.987741) ========= ========= Total master_lag: 0.28 =========