builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0132 starttime: 1459303886.38 results: success (0) buildid: 20160329174740 builduid: 7ca549fe467f48e6b0ce07b9f091c64e revision: 494289c72ba3997183e7b5beaca3e0447ecaf96d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:26.379128) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:26.379635) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:26.380002) ========= 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.2WcxfE44nU/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.ddFAMDucbK/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.005405 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:26.407097) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:26.407812) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:26.427022) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:26.427703) ========= 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.2WcxfE44nU/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.ddFAMDucbK/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.005352 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:26.482380) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:26.483098) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:26.483980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:26.484777) ========= 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.2WcxfE44nU/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.ddFAMDucbK/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-29 19:11:26-- 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% 7.62M=0.002s 2016-03-29 19:11:26 (7.62 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158079 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:26.662835) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:26.663631) ========= 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.2WcxfE44nU/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.ddFAMDucbK/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.019826 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:26.715805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 19:11:26.716641) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 494289c72ba3997183e7b5beaca3e0447ecaf96d --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 494289c72ba3997183e7b5beaca3e0447ecaf96d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2WcxfE44nU/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.ddFAMDucbK/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-29 19:11:26,791 truncating revision to first 12 chars 2016-03-29 19:11:26,791 Setting DEBUG logging. 2016-03-29 19:11:26,792 attempt 1/10 2016-03-29 19:11:26,792 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/494289c72ba3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-29 19:11:27,522 unpacking tar archive at: fx-team-494289c72ba3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.981413 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 19:11:27.719814) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:27.720725) ========= echo 494289c72ba3997183e7b5beaca3e0447ecaf96d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'494289c72ba3997183e7b5beaca3e0447ecaf96d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2WcxfE44nU/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.ddFAMDucbK/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 494289c72ba3997183e7b5beaca3e0447ecaf96d program finished with exit code 0 elapsedTime=0.005414 script_repo_revision: '494289c72ba3997183e7b5beaca3e0447ecaf96d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:27.776992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:27.777683) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 19:11:27.793997) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-03-29 19:11:27.794705) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2WcxfE44nU/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.ddFAMDucbK/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 19:11:27 INFO - MultiFileLogger online at 20160329 19:11:27 in /builds/slave/test 19:11:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:11:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:11:27 INFO - {'append_to_log': False, 19:11:27 INFO - 'base_work_dir': '/builds/slave/test', 19:11:27 INFO - 'blob_upload_branch': 'Fx-Team', 19:11:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:11:27 INFO - 'branch': 'Fx-Team', 19:11:27 INFO - 'buildbot_json_path': 'buildprops.json', 19:11:27 INFO - 'config_files': ('talos/mac_config.py',), 19:11:27 INFO - 'default_actions': ('clobber', 19:11:27 INFO - 'read-buildbot-config', 19:11:27 INFO - 'download-and-extract', 19:11:27 INFO - 'populate-webroot', 19:11:27 INFO - 'create-virtualenv', 19:11:27 INFO - 'install', 19:11:27 INFO - 'run-tests'), 19:11:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:11:27 INFO - 'download_minidump_stackwalk': True, 19:11:27 INFO - 'download_symbols': 'ondemand', 19:11:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:11:27 INFO - 'tooltool.py': '/tools/tooltool.py', 19:11:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:11:27 INFO - '/tools/misc-python/virtualenv.py')}, 19:11:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:11:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:11:27 INFO - 'installer_path': 'installer.exe', 19:11:27 INFO - 'log_level': 'info', 19:11:27 INFO - 'log_name': 'talos', 19:11:27 INFO - 'log_to_console': True, 19:11:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:11:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:11:27 INFO - 'opt_config_files': (), 19:11:27 INFO - 'pip_index': False, 19:11:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:11:27 INFO - 'cmd': ('bash', 19:11:27 INFO - '-c', 19:11:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:11:27 INFO - 'enabled': True, 19:11:27 INFO - 'halt_on_failure': False, 19:11:27 INFO - 'name': 'check_screen_resolution'},), 19:11:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:11:27 INFO - 'cmd': ('bash', 19:11:27 INFO - '-c', 19:11:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:11:27 INFO - 'enabled': True, 19:11:27 INFO - 'halt_on_failure': False, 19:11:27 INFO - 'name': 'check_screen_resolution'},), 19:11:27 INFO - 'run_cmd_checks_enabled': True, 19:11:27 INFO - 'sps_profile': False, 19:11:27 INFO - 'sps_profile_interval': 0, 19:11:27 INFO - 'suite': 'dromaeojs', 19:11:27 INFO - 'system_bits': '32', 19:11:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:11:27 INFO - 'title': 't-yosemite-r7-0132', 19:11:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:11:27 INFO - 'use_talos_json': True, 19:11:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:11:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:11:27 INFO - 'work_dir': 'build'} 19:11:27 INFO - ##### 19:11:27 INFO - ##### Running clobber step. 19:11:27 INFO - ##### 19:11:27 INFO - Running pre-action listener: _resource_record_pre_action 19:11:27 INFO - Running main action method: clobber 19:11:27 INFO - rmtree: /builds/slave/test/build 19:11:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:11:28 INFO - Running post-action listener: _resource_record_post_action 19:11:28 INFO - ##### 19:11:28 INFO - ##### Running read-buildbot-config step. 19:11:28 INFO - ##### 19:11:28 INFO - Running pre-action listener: _resource_record_pre_action 19:11:28 INFO - Running main action method: read_buildbot_config 19:11:28 INFO - Using buildbot properties: 19:11:28 INFO - { 19:11:28 INFO - "project": "", 19:11:28 INFO - "product": "firefox", 19:11:28 INFO - "script_repo_revision": "production", 19:11:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 19:11:28 INFO - "repository": "", 19:11:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 19:11:28 INFO - "buildid": "20160329174740", 19:11:28 INFO - "pgo_build": "False", 19:11:28 INFO - "basedir": "/builds/slave/test", 19:11:28 INFO - "buildnumber": 568, 19:11:28 INFO - "slavename": "t-yosemite-r7-0132", 19:11:28 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 19:11:28 INFO - "platform": "yosemite_r7", 19:11:28 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:11:28 INFO - "branch": "fx-team", 19:11:28 INFO - "repo_path": "integration/fx-team", 19:11:28 INFO - "revision": "494289c72ba3997183e7b5beaca3e0447ecaf96d", 19:11:28 INFO - "stage_platform": "macosx64", 19:11:28 INFO - "builduid": "7ca549fe467f48e6b0ce07b9f091c64e", 19:11:28 INFO - "slavebuilddir": "test" 19:11:28 INFO - } 19:11:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 19:11:28 INFO - Running post-action listener: _resource_record_post_action 19:11:28 INFO - ##### 19:11:28 INFO - ##### Running download-and-extract step. 19:11:28 INFO - ##### 19:11:28 INFO - Running pre-action listener: _resource_record_pre_action 19:11:28 INFO - Running main action method: download_and_extract 19:11:28 INFO - mkdir: /builds/slave/test/build/tests 19:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:28 INFO - https://queue.taskcluster.net/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:11:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 19:11:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 19:11:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 19:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 19:11:30 INFO - Downloaded 1199 bytes. 19:11:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 19:11:30 INFO - Using the following test package requirements: 19:11:30 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 19:11:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:11:30 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 19:11:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:11:30 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 19:11:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:11:30 INFO - u'jsshell-mac.zip'], 19:11:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:11:30 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 19:11:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 19:11:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:11:30 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 19:11:30 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:11:30 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 19:11:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:11:30 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 19:11:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:11:30 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 19:11:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:11:30 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')]} 19:11:30 INFO - https://queue.taskcluster.net/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:11:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:11:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:11:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:11:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:11:32 INFO - Downloaded 17944841 bytes. 19:11:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:11:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:11:35 INFO - Return code: 0 19:11:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:11:35 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')]} 19:11:35 INFO - https://queue.taskcluster.net/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:11:36 INFO - Downloaded 17944841 bytes. 19:11:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:11:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:11:40 INFO - Return code: 0 19:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:40 INFO - https://queue.taskcluster.net/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:11:41 INFO - Downloaded 10847531 bytes. 19:11:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:11:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:11:41 INFO - Return code: 0 19:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:41 INFO - https://queue.taskcluster.net/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:11:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:11:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:11:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 19:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 19:11:44 INFO - Downloaded 111406483 bytes. 19:11:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:11:44 INFO - mkdir: /builds/slave/test/properties 19:11:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:11:44 INFO - Writing to file /builds/slave/test/properties/build_url 19:11:44 INFO - Contents: 19:11:44 INFO - build_url:https://queue.taskcluster.net/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:11:45 INFO - Running post-action listener: _resource_record_post_action 19:11:45 INFO - Running post-action listener: set_extra_try_arguments 19:11:45 INFO - ##### 19:11:45 INFO - ##### Running populate-webroot step. 19:11:45 INFO - ##### 19:11:45 INFO - Running pre-action listener: _resource_record_pre_action 19:11:45 INFO - Running main action method: populate_webroot 19:11:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:11:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:11:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:11:45 INFO - '--tppagecycles', 19:11:45 INFO - '7'], 19:11:45 INFO - 'tests': ['tsvgm']}}, 19:11:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:11:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:11:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:11:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:11:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:11:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:11:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:45 INFO - 'talos_options': ['--e10s'], 19:11:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:45 INFO - 'tests': ['damp', 'tps']}, 19:11:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:45 INFO - 'talos_options': ['--e10s'], 19:11:45 INFO - 'tests': ['damp', 'tps']}, 19:11:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:11:45 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 19:11:45 INFO - 'tests': ['dromaeo_dom']}, 19:11:45 INFO - 'other': {'tests': ['a11yr', 19:11:45 INFO - 'ts_paint', 19:11:45 INFO - 'tpaint', 19:11:45 INFO - 'sessionrestore', 19:11:45 INFO - 'sessionrestore_no_auto_restore', 19:11:45 INFO - 'tabpaint']}, 19:11:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:11:45 INFO - 'tests': ['a11yr', 19:11:45 INFO - 'ts_paint', 19:11:45 INFO - 'tpaint', 19:11:45 INFO - 'sessionrestore', 19:11:45 INFO - 'sessionrestore_no_auto_restore', 19:11:45 INFO - 'tabpaint']}, 19:11:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:11:45 INFO - 'tests': ['a11yr', 19:11:45 INFO - 'ts_paint', 19:11:45 INFO - 'tpaint', 19:11:45 INFO - 'sessionrestore', 19:11:45 INFO - 'sessionrestore_no_auto_restore', 19:11:45 INFO - 'tabpaint']}, 19:11:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:11:45 INFO - 'tests': ['a11yr', 19:11:45 INFO - 'ts_paint', 19:11:45 INFO - 'tpaint', 19:11:45 INFO - 'sessionrestore', 19:11:45 INFO - 'sessionrestore_no_auto_restore', 19:11:45 INFO - 'tabpaint']}, 19:11:45 INFO - 'other_l64': {'tests': ['a11yr', 19:11:45 INFO - 'ts_paint', 19:11:45 INFO - 'tpaint', 19:11:45 INFO - 'sessionrestore', 19:11:45 INFO - 'sessionrestore_no_auto_restore', 19:11:45 INFO - 'tabpaint']}, 19:11:45 INFO - 'other_nol64': {'tests': ['a11yr', 19:11:45 INFO - 'ts_paint', 19:11:45 INFO - 'tpaint', 19:11:45 INFO - 'sessionrestore', 19:11:45 INFO - 'sessionrestore_no_auto_restore', 19:11:45 INFO - 'tabpaint']}, 19:11:45 INFO - 'svgr': {'tests': ['tsvgx', 19:11:45 INFO - 'tsvgr_opacity', 19:11:45 INFO - 'tart', 19:11:45 INFO - 'tscrollx', 19:11:45 INFO - 'cart']}, 19:11:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:11:45 INFO - 'tests': ['tsvgx', 19:11:45 INFO - 'tsvgr_opacity', 19:11:45 INFO - 'tart', 19:11:45 INFO - 'tscrollx', 19:11:45 INFO - 'cart']}, 19:11:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:45 INFO - 'tests': ['tp5o']}, 19:11:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:45 INFO - 'talos_options': ['--e10s'], 19:11:45 INFO - 'tests': ['tp5o']}, 19:11:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:45 INFO - 'talos_options': ['--xperf_path', 19:11:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:45 INFO - 'tests': ['tp5n']}, 19:11:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:45 INFO - 'talos_options': ['--e10s', 19:11:45 INFO - '--xperf_path', 19:11:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:45 INFO - 'tests': ['tp5n']}}, 19:11:45 INFO - 'talos.zip': {'path': '', 19:11:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:11:45 INFO - Running post-action listener: _resource_record_post_action 19:11:45 INFO - ##### 19:11:45 INFO - ##### Running create-virtualenv step. 19:11:45 INFO - ##### 19:11:45 INFO - Running pre-action listener: _resource_record_pre_action 19:11:45 INFO - Running main action method: create_virtualenv 19:11:45 INFO - Creating virtualenv /builds/slave/test/build/venv 19:11:45 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 19:11:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:11:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:11:45 INFO - Using real prefix '/tools/python27' 19:11:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:11:46 INFO - Installing distribute.............................................................................................................................................................................................done. 19:11:49 INFO - Installing pip.................done. 19:11:49 INFO - Return code: 0 19:11:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:11:49 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')]} 19:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:49 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')]} 19:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:49 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 0x1087f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108804420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4a5955f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108693e00>, '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 0x1084bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10868eb20>, '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.2WcxfE44nU/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.ddFAMDucbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 19:11:49 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 19:11:49 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 19:11:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WcxfE44nU/Render', 19:11:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:49 INFO - 'HOME': '/Users/cltbld', 19:11:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:49 INFO - 'LOGNAME': 'cltbld', 19:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:49 INFO - 'MOZ_NO_REMOTE': '1', 19:11:49 INFO - 'NO_EM_RESTART': '1', 19:11:49 INFO - 'PAGER': '/bin/cat', 19:11:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:49 INFO - 'PWD': '/builds/slave/test', 19:11:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:49 INFO - 'SHELL': '/bin/bash', 19:11:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddFAMDucbK/Listeners', 19:11:49 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 19:11:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:49 INFO - 'USER': 'cltbld', 19:11:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:49 INFO - 'XPC_FLAGS': '0x0', 19:11:49 INFO - 'XPC_SERVICE_NAME': '0', 19:11:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:49 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 19:11:49 INFO - Cleaning up... 19:11:49 INFO - Return code: 0 19:11:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:11:49 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')]} 19:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:49 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')]} 19:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:49 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 0x1087f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108804420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4a5955f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108693e00>, '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 0x1084bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10868eb20>, '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.2WcxfE44nU/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.ddFAMDucbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 19:11:49 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 19:11:49 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 19:11:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WcxfE44nU/Render', 19:11:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:49 INFO - 'HOME': '/Users/cltbld', 19:11:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:49 INFO - 'LOGNAME': 'cltbld', 19:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:49 INFO - 'MOZ_NO_REMOTE': '1', 19:11:49 INFO - 'NO_EM_RESTART': '1', 19:11:49 INFO - 'PAGER': '/bin/cat', 19:11:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:49 INFO - 'PWD': '/builds/slave/test', 19:11:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:49 INFO - 'SHELL': '/bin/bash', 19:11:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddFAMDucbK/Listeners', 19:11:49 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 19:11:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:49 INFO - 'USER': 'cltbld', 19:11:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:49 INFO - 'XPC_FLAGS': '0x0', 19:11:49 INFO - 'XPC_SERVICE_NAME': '0', 19:11:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:49 INFO - Downloading/unpacking psutil>=0.7.1 19:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:52 INFO - Installing collected packages: psutil 19:11:52 INFO - Running setup.py install for psutil 19:11:52 INFO - building 'psutil._psutil_osx' extension 19:11:52 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 19:11:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:11:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:11:53 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 19:11:53 INFO - building 'psutil._psutil_posix' extension 19:11:53 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 19:11:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:11:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:11:53 INFO - ^ 19:11:53 INFO - 1 warning generated. 19:11:53 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 19:11:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:53 INFO - Successfully installed psutil 19:11:53 INFO - Cleaning up... 19:11:53 INFO - Return code: 0 19:11:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:53 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 0x1087f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108804420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4a5955f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108693e00>, '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 0x1084bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10868eb20>, '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.2WcxfE44nU/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.ddFAMDucbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 19:11:53 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 19:11:53 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 19:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WcxfE44nU/Render', 19:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:53 INFO - 'HOME': '/Users/cltbld', 19:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:53 INFO - 'LOGNAME': 'cltbld', 19:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:53 INFO - 'MOZ_NO_REMOTE': '1', 19:11:53 INFO - 'NO_EM_RESTART': '1', 19:11:53 INFO - 'PAGER': '/bin/cat', 19:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:53 INFO - 'PWD': '/builds/slave/test', 19:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:53 INFO - 'SHELL': '/bin/bash', 19:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddFAMDucbK/Listeners', 19:11:53 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 19:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:53 INFO - 'USER': 'cltbld', 19:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:53 INFO - 'XPC_FLAGS': '0x0', 19:11:53 INFO - 'XPC_SERVICE_NAME': '0', 19:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:11:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:11:56 INFO - Installing collected packages: mozsystemmonitor 19:11:56 INFO - Running setup.py install for mozsystemmonitor 19:11:56 INFO - Successfully installed mozsystemmonitor 19:11:56 INFO - Cleaning up... 19:11:56 INFO - Return code: 0 19:11:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:11:56 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')]} 19:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:56 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')]} 19:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:56 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 0x1087f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108804420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4a5955f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108693e00>, '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 0x1084bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10868eb20>, '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.2WcxfE44nU/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.ddFAMDucbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 19:11:56 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 19:11:56 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 19:11:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WcxfE44nU/Render', 19:11:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:56 INFO - 'HOME': '/Users/cltbld', 19:11:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:56 INFO - 'LOGNAME': 'cltbld', 19:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:56 INFO - 'MOZ_NO_REMOTE': '1', 19:11:56 INFO - 'NO_EM_RESTART': '1', 19:11:56 INFO - 'PAGER': '/bin/cat', 19:11:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:56 INFO - 'PWD': '/builds/slave/test', 19:11:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:56 INFO - 'SHELL': '/bin/bash', 19:11:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddFAMDucbK/Listeners', 19:11:56 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 19:11:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:56 INFO - 'USER': 'cltbld', 19:11:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:56 INFO - 'XPC_FLAGS': '0x0', 19:11:56 INFO - 'XPC_SERVICE_NAME': '0', 19:11:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:56 INFO - Downloading/unpacking blobuploader==1.2.4 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11:59 INFO - Downloading blobuploader-1.2.4.tar.gz 19:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:11:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:12:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:12: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 19:12: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 19:12: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 19:12: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 19:12: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 19:12: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 19:12:00 INFO - Downloading docopt-0.6.1.tar.gz 19:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:12:00 INFO - Installing collected packages: blobuploader, requests, docopt 19:12:00 INFO - Running setup.py install for blobuploader 19:12:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:12:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:12:00 INFO - Running setup.py install for requests 19:12:01 INFO - Running setup.py install for docopt 19:12:01 INFO - Successfully installed blobuploader requests docopt 19:12:01 INFO - Cleaning up... 19:12:01 INFO - Return code: 0 19:12:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:01 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')]} 19:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:01 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')]} 19:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:01 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 0x1087f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108804420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4a5955f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108693e00>, '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 0x1084bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10868eb20>, '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.2WcxfE44nU/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.ddFAMDucbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 19:12:01 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 19:12:01 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 19:12:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WcxfE44nU/Render', 19:12:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:12:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:12:01 INFO - 'HOME': '/Users/cltbld', 19:12:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:12:01 INFO - 'LOGNAME': 'cltbld', 19:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:01 INFO - 'MOZ_NO_REMOTE': '1', 19:12:01 INFO - 'NO_EM_RESTART': '1', 19:12:01 INFO - 'PAGER': '/bin/cat', 19:12:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:01 INFO - 'PWD': '/builds/slave/test', 19:12:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:12:01 INFO - 'SHELL': '/bin/bash', 19:12:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddFAMDucbK/Listeners', 19:12:01 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 19:12:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:12:01 INFO - 'USER': 'cltbld', 19:12:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:12:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:01 INFO - 'XPC_FLAGS': '0x0', 19:12:01 INFO - 'XPC_SERVICE_NAME': '0', 19:12:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:12:01 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-5foGmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:12:01 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-7OnHMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:12:01 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-wNWCKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:12:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-4yQFnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:12:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-fMcpPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:12:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-sJ5gT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:12:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-KFeZc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:12:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Uh3QLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:12:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-CYDbP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:12:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-ZTdn1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:12:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-CvQx6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:12:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-_UkhQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:12:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-fmhsWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:12:03 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-WxzAlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:03 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-o7BkGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:12:03 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-9esKiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:12:03 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-K6yXZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:12:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:12:03 INFO - Running setup.py install for manifestparser 19:12:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:12:03 INFO - Running setup.py install for mozcrash 19:12:03 INFO - Running setup.py install for mozdebug 19:12:03 INFO - Running setup.py install for mozdevice 19:12:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:12:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:12:04 INFO - Running setup.py install for mozfile 19:12:04 INFO - Running setup.py install for mozhttpd 19:12:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:12:04 INFO - Running setup.py install for mozinfo 19:12:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:12:04 INFO - Running setup.py install for mozInstall 19:12:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:12:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:12:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:12:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:12:04 INFO - Running setup.py install for mozleak 19:12:04 INFO - Running setup.py install for mozlog 19:12:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:12:04 INFO - Running setup.py install for moznetwork 19:12:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:12:05 INFO - Running setup.py install for mozprocess 19:12:05 INFO - Running setup.py install for mozprofile 19:12:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:12:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:12:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:12:05 INFO - Running setup.py install for mozrunner 19:12:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:12:05 INFO - Running setup.py install for mozscreenshot 19:12:05 INFO - Running setup.py install for moztest 19:12:05 INFO - Running setup.py install for mozversion 19:12:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:12:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:12:05 INFO - Cleaning up... 19:12:06 INFO - Return code: 0 19:12:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1087f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108804420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4a5955f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108693e00>, '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 0x1084bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10868eb20>, '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.2WcxfE44nU/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.ddFAMDucbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 19:12:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:12:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:12:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WcxfE44nU/Render', 19:12:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:12:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:12:06 INFO - 'HOME': '/Users/cltbld', 19:12:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:12:06 INFO - 'LOGNAME': 'cltbld', 19:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:06 INFO - 'MOZ_NO_REMOTE': '1', 19:12:06 INFO - 'NO_EM_RESTART': '1', 19:12:06 INFO - 'PAGER': '/bin/cat', 19:12:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:06 INFO - 'PWD': '/builds/slave/test', 19:12:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:12:06 INFO - 'SHELL': '/bin/bash', 19:12:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddFAMDucbK/Listeners', 19:12:06 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 19:12:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:12:06 INFO - 'USER': 'cltbld', 19:12:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:12:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:06 INFO - 'XPC_FLAGS': '0x0', 19:12:06 INFO - 'XPC_SERVICE_NAME': '0', 19:12:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:12:06 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-zje8SP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:12:06 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)) 19:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:12:06 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-5yWxmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:12:06 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-V9DBnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:12:06 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)) 19:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:12:06 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-TS_q45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:12:06 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)) 19:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:12:06 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-LU24Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:12:06 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)) 19:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:12:06 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-SkuZBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:12:06 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)) 19:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:12:06 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-mpwsBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:12:07 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-kmNd2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:12:07 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)) 19:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:12:07 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Hm3mDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:12:07 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)) 19:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:12:07 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-29dy_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:12:07 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)) 19:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:12:07 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-9J1YBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:12:07 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)) 19:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:12:07 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-yTaaRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:12:07 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)) 19:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:12:07 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-X2FTDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:12:07 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)) 19:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:12:07 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-QYLDLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:12:07 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)) 19:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:07 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-hB_tSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:07 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)) 19:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:12:07 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-ddxLT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:12:07 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)) 19:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:12:07 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-_Z0RqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:12:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:10 INFO - Downloading blessings-1.6.tar.gz 19:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:12:10 INFO - Installing collected packages: blessings 19:12:10 INFO - Running setup.py install for blessings 19:12:10 INFO - Successfully installed blessings 19:12:10 INFO - Cleaning up... 19:12:10 INFO - Return code: 0 19:12:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:11 INFO - Reading from file tmpfile_stdout 19:12:11 INFO - Current package versions: 19:12:11 INFO - blessings == 1.6 19:12:11 INFO - blobuploader == 1.2.4 19:12:11 INFO - docopt == 0.6.1 19:12:11 INFO - manifestparser == 1.1 19:12:11 INFO - mozInstall == 1.12 19:12:11 INFO - mozcrash == 0.17 19:12:11 INFO - mozdebug == 0.1 19:12:11 INFO - mozdevice == 0.48 19:12:11 INFO - mozfile == 1.2 19:12:11 INFO - mozhttpd == 0.7 19:12:11 INFO - mozinfo == 0.9 19:12:11 INFO - mozleak == 0.1 19:12:11 INFO - mozlog == 3.1 19:12:11 INFO - moznetwork == 0.27 19:12:11 INFO - mozprocess == 0.22 19:12:11 INFO - mozprofile == 0.28 19:12:11 INFO - mozrunner == 6.11 19:12:11 INFO - mozscreenshot == 0.1 19:12:11 INFO - mozsystemmonitor == 0.0 19:12:11 INFO - moztest == 0.7 19:12:11 INFO - mozversion == 1.4 19:12:11 INFO - psutil == 3.1.1 19:12:11 INFO - requests == 1.2.3 19:12:11 INFO - wsgiref == 0.1.2 19:12:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:11 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 0x1087f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108804420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4a5955f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108693e00>, '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 0x1084bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10868eb20>, '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.2WcxfE44nU/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.ddFAMDucbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 19:12:11 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 19:12:11 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 19:12:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WcxfE44nU/Render', 19:12:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:12:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:12:11 INFO - 'HOME': '/Users/cltbld', 19:12:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:12:11 INFO - 'LOGNAME': 'cltbld', 19:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:11 INFO - 'MOZ_NO_REMOTE': '1', 19:12:11 INFO - 'NO_EM_RESTART': '1', 19:12:11 INFO - 'PAGER': '/bin/cat', 19:12:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:11 INFO - 'PWD': '/builds/slave/test', 19:12:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:12:11 INFO - 'SHELL': '/bin/bash', 19:12:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddFAMDucbK/Listeners', 19:12:11 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 19:12:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:12:11 INFO - 'USER': 'cltbld', 19:12:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:12:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:11 INFO - 'XPC_FLAGS': '0x0', 19:12:11 INFO - 'XPC_SERVICE_NAME': '0', 19:12:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:11 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)) 19:12:11 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)) 19:12:11 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)) 19:12:11 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)) 19:12:11 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)) 19:12:11 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)) 19:12:11 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)) 19:12:11 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)) 19:12:11 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)) 19:12:11 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)) 19:12:11 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)) 19:12:11 INFO - Cleaning up... 19:12:11 INFO - Return code: 0 19:12:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:11 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 0x1087f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108804420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4a5955f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108693e00>, '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 0x1084bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10868eb20>, '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.2WcxfE44nU/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.ddFAMDucbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 19:12:11 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 19:12:11 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 19:12:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WcxfE44nU/Render', 19:12:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:12:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:12:11 INFO - 'HOME': '/Users/cltbld', 19:12:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:12:11 INFO - 'LOGNAME': 'cltbld', 19:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:11 INFO - 'MOZ_NO_REMOTE': '1', 19:12:11 INFO - 'NO_EM_RESTART': '1', 19:12:11 INFO - 'PAGER': '/bin/cat', 19:12:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:11 INFO - 'PWD': '/builds/slave/test', 19:12:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:12:11 INFO - 'SHELL': '/bin/bash', 19:12:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddFAMDucbK/Listeners', 19:12:11 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 19:12:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:12:11 INFO - 'USER': 'cltbld', 19:12:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:12:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:11 INFO - 'XPC_FLAGS': '0x0', 19:12:11 INFO - 'XPC_SERVICE_NAME': '0', 19:12:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:11 INFO - Downloading/unpacking jsonschema 19:12:11 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 19:12:11 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 19:12:11 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 19:12:11 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 19:12:11 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 19:12:11 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 19:12:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:12:13 INFO - Downloading/unpacking functools32 (from jsonschema) 19:12:13 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 19:12:13 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 19:12:13 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 19:12:13 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 19:12:13 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 19:12:13 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 19:12:14 INFO - Downloading functools32-3.2.3-2.tar.gz 19:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:12:14 INFO - warning: no files found matching '*.txt' 19:12:14 INFO - no previously-included directories found matching 'build' 19:12:14 INFO - no previously-included directories found matching 'dist' 19:12:14 INFO - no previously-included directories found matching '.git*' 19:12:14 INFO - Installing collected packages: jsonschema, functools32 19:12:14 INFO - Running setup.py install for functools32 19:12:14 INFO - warning: no files found matching '*.txt' 19:12:14 INFO - no previously-included directories found matching 'build' 19:12:14 INFO - no previously-included directories found matching 'dist' 19:12:14 INFO - no previously-included directories found matching '.git*' 19:12:14 INFO - Successfully installed jsonschema functools32 19:12:14 INFO - Cleaning up... 19:12:14 INFO - Return code: 0 19:12:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:12:14 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')]} 19:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:14 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')]} 19:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:14 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 0x1087f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108804420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4a5955f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108693e00>, '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 0x1084bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10868eb20>, '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.2WcxfE44nU/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.ddFAMDucbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 19:12:14 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 19:12:14 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 19:12:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WcxfE44nU/Render', 19:12:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:12:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:12:14 INFO - 'HOME': '/Users/cltbld', 19:12:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:12:14 INFO - 'LOGNAME': 'cltbld', 19:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:14 INFO - 'MOZ_NO_REMOTE': '1', 19:12:14 INFO - 'NO_EM_RESTART': '1', 19:12:14 INFO - 'PAGER': '/bin/cat', 19:12:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:14 INFO - 'PWD': '/builds/slave/test', 19:12:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:12:14 INFO - 'SHELL': '/bin/bash', 19:12:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddFAMDucbK/Listeners', 19:12:14 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 19:12:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:12:14 INFO - 'USER': 'cltbld', 19:12:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:12:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:14 INFO - 'XPC_FLAGS': '0x0', 19:12:14 INFO - 'XPC_SERVICE_NAME': '0', 19:12:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:15 INFO - Downloading/unpacking flake8 19:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:12:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:12:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:12:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:12:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:12:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:12:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:12:18 INFO - no previously-included directories found matching 'docs/_build' 19:12:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:12:18 INFO - Running setup.py install for pep8 19:12:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:12:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:12:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:12:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:12:18 INFO - no previously-included directories found matching 'docs/_build' 19:12:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:12:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:12:18 INFO - Cleaning up... 19:12:19 INFO - Return code: 0 19:12:19 INFO - Running post-action listener: _resource_record_post_action 19:12:19 INFO - Running post-action listener: _start_resource_monitoring 19:12:19 INFO - Starting resource monitoring. 19:12:19 INFO - ##### 19:12:19 INFO - ##### Running install step. 19:12:19 INFO - ##### 19:12:19 INFO - Running pre-action listener: _resource_record_pre_action 19:12:19 INFO - Running main action method: install 19:12:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:19 INFO - Reading from file tmpfile_stdout 19:12:19 INFO - Detecting whether we're running mozinstall >=1.0... 19:12:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:12:19 INFO - Reading from file tmpfile_stdout 19:12:19 INFO - Output received: 19:12:19 INFO - Usage: mozinstall [options] installer 19:12:19 INFO - Options: 19:12:19 INFO - -h, --help show this help message and exit 19:12:19 INFO - -d DEST, --destination=DEST 19:12:19 INFO - Directory to install application into. [default: 19:12:19 INFO - "/builds/slave/test"] 19:12:19 INFO - --app=APP Application being installed. [default: firefox] 19:12:19 INFO - mkdir: /builds/slave/test/build/application 19:12:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:12:53 INFO - Reading from file tmpfile_stdout 19:12:53 INFO - Output received: 19:12:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:12:53 INFO - Running post-action listener: _resource_record_post_action 19:12:53 INFO - ##### 19:12:53 INFO - ##### Running run-tests step. 19:12:53 INFO - ##### 19:12:53 INFO - Running pre-action listener: _resource_record_pre_action 19:12:53 INFO - Running main action method: run_tests 19:12:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:12:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:12:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:12:53 INFO - 2016-03-29 19:12:53.023 screenresolution[1933:11517] starting screenresolution argv=screenresolution get 19:12:53 INFO - 2016-03-29 19:12:53.025 screenresolution[1933:11517] Display 0: 1600x1200x32@60 19:12:53 INFO - 2016-03-29 19:12:53.031 screenresolution[1934:11520] starting screenresolution argv=screenresolution list 19:12:53 INFO - Available Modes on Display 0 19:12:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:12:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:12:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:12:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:12:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:12:53 INFO - Intel Iris: 19:12:53 INFO - Chipset Model: Intel Iris 19:12:53 INFO - Type: GPU 19:12:53 INFO - Bus: Built-In 19:12:53 INFO - VRAM (Dynamic, Max): 1536 MB 19:12:53 INFO - Vendor: Intel (0x8086) 19:12:53 INFO - Device ID: 0x0a2e 19:12:53 INFO - Revision ID: 0x0009 19:12:53 INFO - Displays: 19:12:53 INFO - Display: 19:12:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:12:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:12:53 INFO - Display Serial Number: 1600x1200 60 19:12:53 INFO - Main Display: Yes 19:12:53 INFO - Mirror: Off 19:12:53 INFO - Online: Yes 19:12:53 INFO - Rotation: Supported 19:12:53 INFO - Return code: 0 19:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:12:53 INFO - Python 2.7.3 19:12:53 INFO - Return code: 0 19:12:53 INFO - grabbing minidump binary from tooltool 19:12: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')]} 19:12:53 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 0x108693e00>, '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 0x1084bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10868eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:12:53 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 19:12:53 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 19:12:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:12:53 INFO - Return code: 0 19:12:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:12:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:12:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:12:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:12:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:12:54 INFO - Return code: 0 19:12:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0132 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:12:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WcxfE44nU/Render', 19:12:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:12:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:12:54 INFO - 'HOME': '/Users/cltbld', 19:12:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:12:54 INFO - 'LOGNAME': 'cltbld', 19:12:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:12:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:54 INFO - 'MOZ_NO_REMOTE': '1', 19:12:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:12:54 INFO - 'NO_EM_RESTART': '1', 19:12:54 INFO - 'PAGER': '/bin/cat', 19:12:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:54 INFO - 'PWD': '/builds/slave/test', 19:12:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:12:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:12:54 INFO - 'SHELL': '/bin/bash', 19:12:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddFAMDucbK/Listeners', 19:12:54 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 19:12:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:12:54 INFO - 'USER': 'cltbld', 19:12:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:12:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:54 INFO - 'XPC_FLAGS': '0x0', 19:12:54 INFO - 'XPC_SERVICE_NAME': '0', 19:12:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:12:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:12:54 INFO - mozversion application_buildid: 20160329174740 19:12:54 INFO - mozversion application_changeset: 494289c72ba3997183e7b5beaca3e0447ecaf96d 19:12:54 INFO - mozversion application_display_name: Nightly 19:12:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:12:54 INFO - mozversion application_name: Firefox 19:12:54 INFO - mozversion application_remotingname: firefox 19:12:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:12:54 INFO - mozversion application_vendor: Mozilla 19:12:54 INFO - mozversion application_version: 48.0a1 19:12:54 INFO - mozversion platform_buildid: 20160329174740 19:12:54 INFO - mozversion platform_changeset: 494289c72ba3997183e7b5beaca3e0447ecaf96d 19:12:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:12:54 INFO - mozversion platform_version: 48.0a1 19:12:54 INFO - using testdate: 1459303974 19:12:54 INFO - actual date: 1459303974 19:12:54 INFO - starting webserver on 'localhost:51454' 19:12:54 INFO - SUITE-START | Running 2 tests 19:12:54 INFO - TEST-START | dromaeo_css 19:12:54 INFO - operating with platform_type : mac_ 19:12:54 INFO - Initialising browser for dromaeo_css test... 19:12:54 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpudmGPL/profile http://localhost:51454/getInfo.html) 19:12:57 INFO - PROCESS | 1952 | __metrics Screen width/height:1600/1200 19:12:57 INFO - PROCESS | 1952 | colorDepth:24 19:12:57 INFO - PROCESS | 1952 | Browser inner width/height: 1024/689 19:12:57 INFO - PROCESS | 1952 | __metrics 19:12:57 INFO - PROCESS | 1952 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:12:57 ERROR - PROCESS | 1952 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:12:58 INFO - TEST-INFO | 1952: exit 0 19:12:58 INFO - Browser initialized. 19:12:58 INFO - Running cycle 1/1 for dromaeo_css test... 19:12:58 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpudmGPL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:13:10 INFO - PROCESS | 1955 | RSS: Main: 244826112 19:13:10 INFO - PROCESS | 1955 | 19:14:01 INFO - PROCESS | 1955 | 1459304041813 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] 19:16:10 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51454/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51454/tests/dromaeo/cssquery-ext.html) 19:16:13 INFO - PROCESS | 1955 | RSS: Main: 480153600 19:16:13 INFO - PROCESS | 1955 | 19:19:16 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51454/tests/dromaeo/cssquery-ext.html (next: http://localhost:51454/tests/dromaeo/cssquery-jquery.html) 19:19:16 INFO - PROCESS | 1955 | RSS: Main: 379854848 19:19:16 INFO - PROCESS | 1955 | 19:22:18 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51454/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51454/tests/dromaeo/cssquery-mootools.html) 19:22:19 INFO - PROCESS | 1955 | RSS: Main: 378585088 19:22:19 INFO - PROCESS | 1955 | 19:25:21 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51454/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51454/tests/dromaeo/cssquery-prototype.html) 19:25:22 INFO - PROCESS | 1955 | RSS: Main: 339275776 19:25:22 INFO - PROCESS | 1955 | 19:28:25 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51454/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51454/tests/dromaeo/cssquery-yui.html) 19:28:25 INFO - PROCESS | 1955 | RSS: Main: 342183936 19:28:25 INFO - PROCESS | 1955 | 19:31:28 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51454/tests/dromaeo/cssquery-yui.html (next: http://localhost:51454/tests/dromaeo/cssquery-dojo.html) 19:31:28 INFO - PROCESS | 1955 | RSS: Main: 387022848 19:31:28 INFO - PROCESS | 1955 | 19:31:28 INFO - PROCESS | 1955 | __start_tp_report 19:31:28 INFO - PROCESS | 1955 | _x_x_mozilla_page_load 19:31:28 INFO - PROCESS | 1955 | _x_x_mozilla_page_load_details 19:31:28 INFO - PROCESS | 1955 | |i|pagename|runs| 19:31:28 INFO - PROCESS | 1955 | |0;dojo.html;3403.2002479417333;3452.4130897747395;3480.808555529448;3485.477178423237;3524.7885126892375;5499.532539734128;5554.555635549156;5609.35492418372;5624.10014397696;5627.155926611005;5600.0759874620635;5625.578081643883;5731.770729170828;5780.855478613037;5811.418858114186;5052.621053421009;5071.290019397287;5093.337866077405;5108.591312694975;5163.3545806774155;4502.932456013146;4838.298446725223;5204;5234.345706786652;5243.868903277429;4999.600031997432;5082.669626474304;5112.872178195537;5143.151380022292;5186.299849520323;5082.847514574569;5096.490350964911;5098.847034588968;5103.515166059218;5105.055564720538;5030.245463180516;5032.798688052473;5051.191809310492;5057.418396884369;5068.847934561969;5519.061759500854;5530.695811730353;5534.059209934321;5544.528715059225;5563.109902415635;6104.816855494342;6107.674343494563;6120.938790612081;6125.509959203253;6193.256809182927;6103.786367477162;6195.411435913581;6252.812415627538;6272.843178920518;6280.654563998978;5728.942710572925;5757.740901659394;5763.6541807491685;5765.192872997742;5766.538676905838;6135.7852475164045;6211.3167551569295;6252.093446450239;6259.4679452246155;6275;6076.726547305382;6085.482733967574;6086.908696369558;6088.299845517822;6099.9390006099375;6194.5973511721595;6199.969000155061;6200.627962322275;6217.067439884054;6224.284207316126;5981.910271345933;6060;6103.877922441615;6106.175666285084;6124.908126378108;6108.9795837225665;6120.782376608313;6122.2353486564425;6131.399973055325;6141.355157708465;4824.710517368969;4829.44461386945;4829.589484893753;4840.515948405131;4870.366852309177;3613.8735144269826;4354.8258069677495;4360.302351623725;4366.454193225847;4381.9342709859375;5604.215409842625;5633.126865335879;5639.943600563942;5694.5159661428415;5700.40145784695;6183.81448556544;6246.593971391845;6253.093301471261;6261.8747625047245;6303.464205542488;5478.315210598676;5542.944570554324;5578.860528486739;5591.6365436246515;5611.7474713637985;5290.206469029677;5319.069162896478;5347.224652425377;5362.65142765719;5380.381256155514;6252.499800015988;6260.780872669435;6273.874522509615;6280.340564240689;6284.183056202664;6091.1472393864005;6176.28972668131;6236.656983865931;6237.126802247598;6248.812535623939;6217.813465596039;6259.217597800275;6295.213098362705;6297.338779428094;6303.086052522267;5174.275601415729;6065.059915713072;6071.332153463204;6131.621347939075;6190.876182476235;6207.255129384323;6214.4407003369915;6216.844578885564;6229.345918678655;6230.127782110599;6059;6062.575619706578;6079.209702738615;6092.664903430354;6094.238220222473;5616.0733478977145;5865;5873.676947767914;5893.057110862242;5893.351731309467;5784.94215057844;5806.042003069446;5813.94186058134;5819.418058194146;5833.387494313036;5903.2325797646035;5913.58604897653;5930.199423077829;5987.6108052976415;5990.7004649768205;5799.652020878761;5805.419458054161;5805.94194058054;5876.382979787061;5890.793822216202 19:31:28 INFO - PROCESS | 1955 | |1;ext.html;450.6214779585148;451.38836876032974;464.80942813446495;573.4580821124038;618.2550027217202;36460.08849778757;38905.80547097264;39062;39120.21759564807;39220.80389598055;42235.57764422355;42624.36063459051;42638.786806066004;42716.71849844502;42866.92832679184;9542.332036757447;9770.071843174923;9786.706398808046;9791.265655075862;9792.657256996006;9584.377015494005;9731.075547822946;9751.26865485088;9753.707388778312;9754.46350450725;8970.59632316544;9470.863496380443;9757.609695612167;9768.951155244215;9784.26618003649;9642.566084526177;9673.226141908666;9757.268204884662;9759.414435133915;9778.462184579845;9587.424754514752;9633.421994680342;9637.18083962864;9734.610615575368;9738.220942324597;41080.794596026826;41442.58557414418;41443.585564144276;41455.7927210365;41492.37761433581;3248.9837550812094;3402.795832250048;3434.0384692286198;3472.878449254264;3630.8366123524506;28613.57079643807;28835.84656613733;29102.70897291021;29439.67521461518;29536.26159346012;2271.432141964509;2378.881055947196;2718.932026699348;2757.7104404037686;2791.9720802791917;480078;480570;480625;480788;481475;55865.44134558603;57191.71404143036;64663.67668161723;65146.348536514975;65372.67313663401;46376;52975.47024529705;68171.97742033874;69370.65314673496;69693;16671.749923751155;16879.831201687826;17191.656166876593;17196.968181909124;17246.91376543109;12897.355132243538;12911.806322905164;12915.418806153746;12927.482900684055;12944.741105177844;14345.78481322781;17460.91269543644;17731;17792.199351029234;19385.72197094983;6698.397144256943;7668.424868134912;7980.720674776355;8038.276555110068;8070.538485761782;908.1644886704116;920.5259291464901;959.7072892767773;1011.7976404719086;1038.5586125896614;22669.433264168198;28386.006489772757;28567.28581785472;29038.274043148667;29251.853740731585;1068.9144868410665;1088.6189833558349;1123.646051493777;1140.3556990300453;1213.8968187704145;11668.76662466746;12894.48422063107;14883.404663813326;15468.690626187414;15790.9210453947;513318;513624;527471;527707;527824;59732.70133649391;60151.09773353403;60250.69874650599;60252.698736506034;60412.697936510034;1466.3548038862866;1478.64512516993;1491.8135233095863;1499.8125234345707;1616.2080580515462;25135.24594262175;29530.114096577137;29659.555106673848;30467.933622324;30564.847175763978;46964.53035469601;55451;56728;56771.71614141903;56966;339309;344140;346382;347022;347216;28578.714212857605;28971;28984.710152898202;28993.275168120967;33020.66979330272;33620.495692564145;43408.782956085015;43640;43890.122197556506;44047;35832.64167358293;36002.73990410428;36079.639203608676;36957.63042369542;36980.26039479142;36516.88745673776;36822.8158859204;36904.44643330406;37684.43473347847;37737.62262377341;36474.8176259117;36514.8174259127;36954.815225923696;37391.06522336963;37589.248215035;32196.83901580477;32497.35005299928;32956.67043329632;33274.835380762524;33452.33095338031;21524;24268.75731242665;24359;25048;25086.37284067913 19:31:28 INFO - PROCESS | 1955 | |2;jquery.html;310.2352700593039;361.75942997906395;363.2136424640653;372.7968257299773;372.82290911816875;19651.213951441943;19670.508237294074;21072.473188170265;21094.472638184052;21100.472488187803;19788.50528736782;19850.205991760347;20488.385348439533;20516.38450846477;20527.486812829688;5776.364599894008;5995.730192141364;6043.214382130317;6043.486303664194;6052;4229.767362795045;4291.935620965688;4515.706479078865;5980.760769569212;6657.101291325657;6589.769358072468;6669.333066693341;6693.933060669379;6704.229013663418;6716.6977486013;6675.499337549654;6677.866442671144;6683.699233534503;6684.431823295025;6689.163854518185;3793.8103094845146;5446.509814116748;5733.168690539848;5747.109198074305;5757.395473475267;25264.368390790194;25746.227613171635;26045.609315860278;26059.478810423687;26079.217623471326;2013.6375452418558;2120.427484579155;2179.3154280193417;2269.8751568663715;2287.4052746286084;14362.64093397663;14410.92794536031;14958.925205373904;15072.246387680681;15170.772438413433;1740.26908698347;1767.6287979524316;1784.7506745278356;1786.4100950154373;1805.3139806873305;97688.51155744247;98481.5075924623;99165;99903.99999999927;100626.99999999927;10313.639022634172;10565.841512377321;10767.3539587625;10813.729656758487;10875.293105948089;13207.471701131846;13301.201927884358;13308.401121949535;13313.46746130144;13351.132176408502;8089.919100809035;8522.138013562002;8569.785755356166;8775.210231079234;8865.468071915706;8134.430589858772;8353.874691879626;9006.369554131279;9062.456252624863;9179.311551633655;6125.387461253839;6216.160818289473;6223.471004964629;6247.937520624827;6312.5581209314905;1746.9301227950994;1772.5657213982656;1779.4839496546115;1808.8643351748408;1831.230883029131;939.0984654731398;941.5574679900436;960.1934375124929;1040.8282633365561;1053.1890444357803;16406.917965410095;20286.59426811485;20924.895375523025;22053.33839984803;22207;916.3219217778795;940.8494640857567;956.3521286547374;985.4924713772413;1055.7413433708637;10983.890161098287;11352.886471135349;11358.772824543463;11365.204435689588;11411.60059397917;624249;630454.6499885009;637598;639190;642569;125655.37172314263;127597;127864;129122;131191;1085.3650614390513;1086.1745073743853;1103.7957977774138;1104.867415910112;1105.165599972016;18380.063862002087;18438.170282337058;18761.249550017845;18993.24027038903;19019;51032;53379.46620533745;54033.919321614136;54213.915721686135;54270;55821;78308.2169178301;78571.0714464286;80209.59895200486;81155.5942220285;6481.222253329631;7382.741604043833;7964;8001.279884810395;8049.034115906129;11047.558097676003;11594.47824847867;11973.820392694292;12157.209781364183;12394.3183124929;10465.267431280043;10783.352998820095;11038.17213708991;11077.833832492357;11141.387223702774;10437.634682786065;10675.466226688479;10827.945860270964;11019.83470247931;11031.282966607145;10016.248781341283;10253.33413312559;11045.061169800336;11336;11347.37589432589;7656.4640475168435;7660.885086723815;7752.92247077522;7827.804304892195;8047.557384343683;7939.84120317602;9884;10869.78260434771;11147.219694621623;11151.386673733023 19:31:28 INFO - PROCESS | 1955 | |3;mootools.html;1448.4640682947297;1461.1525315317115;1551.0771091200736;1758.2791055667178;1874.784399794024;8046.758597242085;8840.160184782444;8979.14698103679;8984.820303593924;9013.72958811235;8601.010883748371;8873.68942087027;8889.111088891108;8902.109789021095;8939.329550283723;2179.1065663078143;2396.1613435297595;2472.7156377016604;2492.190038237571;2516.924492265235;2376.2158487699103;2381.6665666806575;2386.3914701751028;2387.988060059697;2390.5696974544576;2343.6953196084487;2374.2165085521824;2412.529556736437;2413.3122060212845;2413.553492603874;2398.436367453647;2437.244454219198;2446.425090103824;2474.9010039598393;2485.005997600965;2464.827462077655;2495.089292408276;2504.8622325772076;2507.924762257135;2513.9245822625167;8972;9054.77363065922;9064.728058158265;9069;9101.499417532099;5477.534409575151;5665.54675625953;5665.830025099253;5666.716664166816;5671.347795003545;3400.897973060812;3600.7119430445764;3688.0226739913946;3789.8863034108745;3792.6207379262128;1044.2977945948132;1067.114295135036;1069.2996087562658;1082.2370228988623;1083.128081894075;12176.878231217663;12186.329751863645;12188.329641869694;12194.268343899306;12214.450349734283;3948.3879998599687;4903.926441103386;4984.850454486371;4990.126727822617;5004;10402.219833512365;10421.739456513647;10427.113695335982;10430.322029068238;10438.582456701646;5589.105743081088;5604.439556044363;5643.463870932255;5649.915251271234;5654.180143879114;4494.16857881293;4588.334691469719;4881.072596206709;5070.873228169326;5072.923906141411;3854.5952674969285;3949.2299001694396;3952.5454572724507;3991.221711766236;4031.113155105872;1309.7249577588814;1317.157019507516;1320.148504214776;1326.681596416853;1333.8932885369147;1157.1610582327912;1382.1706975814432;1398.8181536400202;1425.1164278147614;1429.6068581140062;8227.341812655093;8300.958495207486;8302.418830681914;8324.791880202922;8344.499330040217;973.9513024348754;1227.5212667059855;1228.662117917562;1263.3809433377762;1272.7772639788;6360;6411.6153030818305;6422.903656445157;6435.2599451063725;6465.77369792055;10304.484775761182;10932.344059356465;10937.4531273436;11090.833637495443;11098.167637427225;10534.315269507457;10747.764007139123;10944.343339399662;11051.005409513182;11060.889391106148;8455.069942306342;8485.363597730071;8615.956920215483;8625.353098517637;8625.827483450421;7951.443398962017;8048.275655191061;8099.757007289791;8108.797280068045;8147.470414423044;9632.9036709632;9765.169960553148;9863.309568330147;9972.955544113294;10004;7671.923280767121;10097.798044038931;10125.291229614151;10151.441670708182;10303.742406439898;6458.128152699325;6681.1314529110905;6784.559003664746;7153.141623005273;7274.636268186676;8354.916450835413;8385.245327920517;8411.45325553837;8423.663053478038;8437.915620843713;6102.267727872683;7325.230850760593;7352.595607241653;7432;7544.962275188589;7250.564966102051;7270.200277969525;7380.151282602569;7402.851942961003;7422.96288518554;7821.648025838737;7935.484193527403;7938.404619653434;7940.841183176189;7940.920590794018;6856.862862742817;6872.175338959357;6934.965325173342;6938.167419909643;6945.992831039572;7139;7187.748428804966;7197.424206063398;7203.063601731741;7208.171060328129 19:31:28 INFO - PROCESS | 1955 | |4;prototype.html;325.6141472355259;329.80211872876276;332.8252667349642;333.7797053944397;337.6252359880532;6690.6654667266685;6745.898811517831;6752.257251702309;6756.223034351045;6770.5937643741345;6657.866842663144;6704.966475167629;6705.865882682343;6719.697613607387;6736.528443008991;3958.6437220650137;4709.364235828154;4774.021325628255;4852.320675105488;4954.777035033432;4284.528701842794;4527.56988086133;4801.855944321676;4840.782164802592;4841.8305359312435;4775.212090005145;4776.593989510896;4783.71297722136;4790.23356262998;4852.490488498692;4668.789904454291;4751.406074240703;4854.587360074363;4857.587105096071;4875.658703890729;4149.543550209474;4150.813213405404;4162.500499939996;4177.22721296558;4182.728122672047;6424.100625912376;6434.58175218614;6505.902411463831;6506.024096385533;6508.186476690414;5861.413858614147;5866.384029676865;5872.823815285506;5875.089361149029;5892.234009578728;6718.899216511756;7138.214796372395;7142.21435642079;7145.178304494998;7148.571085734872;4567;4585.541445855421;4604.033153037833;4613.469451013143;4647.442306923191;7424.220456852061;7514.0231769870115;7523;7531.359834414081;7539.585322807244;3991.1618560102124;4373.453318335208;4615.492295847454;4648.465426475931;4658.720476771405;3955.446237526691;4710.222813235846;4725.243960966229;4726.79466735987;4746.833860814855;5652.8869422611315;5661.915071273934;5663.943360566424;5666.15007748841;5679;6828;7141.071660684078;7148.39238664709;7161.785146445615;7182.42540596751;1262.8484581850237;1460.160407765518;1645.3171933647402;1647.4316360855485;1651.587103224194;974.055166488505;1002.0880998291519;1029.912457441126;1031.633770011635;1057.7249915021996;5524.558035357242;6537.346265373425;6743.954687023519;6774.153230846145;6784.694688739019;7485.700571977169;7490.85018299631;7494.362979146725;7496.925030749622;7508.774736757797;6739.865202695919;6740.966295168493;6747.460203183734;6747.628880411527;6759.2226893906845;3802.771833689932;3897.3179693553516;3942.073612701013;3946.5264168299987;3955.960440395617;7775.261350171724;7782.143964163937;7833.49082309648;7839.882401763978;7861.921380786119;6250.437460628475;7683.346915512132;7685.4620176587105;7701.460897737216;7711.344535714527;7793.61031948389;7801.687932482637;7810.179931107152;7812.218778122256;7814.984052073308;6633.270340262664;6657.201135863727;7438.442116841366;7470.775876723707;7471.626418679153;5926.4666180044005;7161.57030578167;7295.927040729524;7305.488615796843;7306.452016098708;6957.678041172161;7126.2873712628325;7183.138023437221;7733.265339792711;7793.025871766029;4662.417197850269;4664.440267167962;4675.064987002545;4678.321643361625;4680.812767489262;5987.640741555347;7158.642067896689;7394.334509894135;7429.628518574158;7431.554106753612;7123.430125590044;7166.57000579946;7172.569645821268;7188.568685878864;7199.6760145794615;7148.714051437884;7154.856902862018;7162.964185179041;7164.283571642794;7172.462065345225;7020.297970202939;7035.6833942471685;7041.753538626123;7053.294670532906;7057.188423331382;6862.691178896862;7176.354128128493;7189.7483588074165;7191.137063552407;7217.855642887218;6724.991251312146;6846.931530684828;6891.75878844238;6979.953007048984;7005.474589405713 19:31:28 INFO - PROCESS | 1955 | |5;yui.html;672.3377473188909;756.4364548411432;758.6510205305563;758.8520238553481;767.2251026463271;15159.545213643594;15448.382064717413;15456.381744730212;17708;18242.726359104625;16513;16515.58711032225;16593.253303601337;16609.920355176906;16615.83384166158;758.5789886612928;920.052346083535;948.8434408322653;949.7150854743584;950.7100334398006;755.9017327747385;916.9174774270315;943.4905151218334;944.7590864329586;945.4091193004373;990.3315262198023;999.0808456220295;999.7100840756171;999.9250056245775;1000.1998401278984;787.5707739282105;968.4383057826444;987.2940847294183;992.602958816472;997.7405874472616;738.6048464071749;739.7484855149221;741.2328240271294;741.7070257248357;745.7725393754903;13802.65493362674;14802.925985370004;15479.380824766995;15597.68804623901;15627.531174064796;12309.507619695201;12355.135140540166;12508.874911250861;12518.374081295899;12830.486780528767;9917.603295868228;10205.336653117523;10241.74395640115;10256.589736410535;10535.10451611614;2953.8670759815645;3509.298140371936;3555.1467647764352;3598.946015809765;3618.4572314152824;89765.55117224372;89964.10035899622;90846.54576727074;91109.54445227732;91386.99999999933;8098.635561399751;9430.669926552539;9479.526023698925;9579.664711735195;9901.306908516335;22169;22178.33464996053;22191;22226.88886555589;22231.444213894458;7253.057102576737;7373.29953654402;7405.703771849174;7425.702971881173;7592.506487078323;4121.319982202903;4176.791160441966;4177.582241775798;4178.05993651426;4185.727927684691;3497.965020349764;3553.058439513531;3553.1650062235353;3553.34263161316;3561.9643803561635;644.2856929799708;657.7076045570382;657.8322527755391;668.752561552219;673.0035384722103;594.5986459140063;612.9233845769279;620.5470006894992;624.6689254695019;628.7556209956603;7908.52548847071;8047.235512626291;8152.510849349058;8358.080611132771;8440.57797110142;517.4721783780523;584.5791030458148;616.892043892317;635.3233805996599;642.4250295985161;3857.672097871656;3902.35611124167;4000.699947503949;4006.759594424344;4013.607131328635;98858.51712224323;99713;101948.27594826542;102157;102211;65450.36374090686;83072;83471;83639;85313;69544.26139346557;69872.60254794876;71516;71585.6420717893;73128;7729.6521656524465;7921.32668723165;7954;8008.639611217625;8200.138985406445;51794.74102629463;52688.47311526836;52970.2054469191;53263.82502299092;53276.4672353287;68618.31381686318;69485.88225883835;71223.5755284881;72827.63586182035;72859;9872.605095796087;10109.595616175564;10197.796044079225;10246.590136394461;10819.459027048459;9313.86029209576;11168.880417535624;11309.434528273388;11357.318560886373;11518.136139789716;10571.577136914744;10795.19036072282;10880.238383313408;10884.673459796219;10893.509792059534;10419.94790026045;10511.737206569896;10595.417252051211;10597.364158150227;10891.346519208873;10566.735831604272;10584.629537966135;10599.364038157735;10814.89185108139;10851.782964340511;8900.287976961697;9010.098990100938;9045.819083618422;9147.725568232963;9159.267258619428;8688.13118688126;8716.956415217883;8915.955420222857;9339.392939458914;9567.425954442755 19:31:28 INFO - PROCESS | 1955 | __end_tp_report 19:31:28 INFO - PROCESS | 1955 | __start_cc_report 19:31:28 INFO - PROCESS | 1955 | _x_x_mozilla_cycle_collect,2402 19:31:28 INFO - PROCESS | 1955 | __end_cc_report 19:31:28 INFO - PROCESS | 1955 | __startTimestamp1459305088948__endTimestamp 19:31:28 INFO - PROCESS | 1955 | 19:31:28 INFO - PROCESS | 1955 | ------- Summary: start ------- 19:31:28 INFO - PROCESS | 1955 | Number of tests: 6 19:31:28 INFO - PROCESS | 1955 | 19:31:28 INFO - PROCESS | 1955 | [#0] dojo.html Cycles:165 Average:5658.47 Median:5813.94 stddev:645.36 (11.1%) stddev-sans-first:622.61 19:31:28 INFO - PROCESS | 1955 | Values: 3403.2 3452.4 3480.8 3485.5 3524.8 5499.5 5554.6 5609.4 5624.1 5627.2 5600.1 5625.6 5731.8 5780.9 5811.4 5052.6 5071.3 5093.3 5108.6 5163.4 4502.9 4838.3 5204.0 5234.3 5243.9 4999.6 5082.7 5112.9 5143.2 5186.3 5082.8 5096.5 5098.8 5103.5 5105.1 5030.2 5032.8 5051.2 5057.4 5068.8 5519.1 5530.7 5534.1 5544.5 5563.1 6104.8 6107.7 6120.9 6125.5 6193.3 6103.8 6195.4 6252.8 6272.8 6280.7 5728.9 5757.7 5763.7 5765.2 5766.5 6135.8 6211.3 6252.1 6259.5 6275.0 6076.7 6085.5 6086.9 6088.3 6099.9 6194.6 6200.0 6200.6 6217.1 6224.3 5981.9 6060.0 6103.9 6106.2 6124.9 6109.0 6120.8 6122.2 6131.4 6141.4 4824.7 4829.4 4829.6 4840.5 4870.4 3613.9 4354.8 4360.3 4366.5 4381.9 5604.2 5633.1 5639.9 5694.5 5700.4 6183.8 6246.6 6253.1 6261.9 6303.5 5478.3 5542.9 5578.9 5591.6 5611.7 5290.2 5319.1 5347.2 5362.7 5380.4 6252.5 6260.8 6273.9 6280.3 6284.2 6091.1 6176.3 6236.7 6237.1 6248.8 6217.8 6259.2 6295.2 6297.3 6303.1 5174.3 6065.1 6071.3 6131.6 6190.9 6207.3 6214.4 6216.8 6229.3 6230.1 6059.0 6062.6 6079.2 6092.7 6094.2 5616.1 5865.0 5873.7 5893.1 5893.4 5784.9 5806.0 5813.9 5819.4 5833.4 5903.2 5913.6 5930.2 5987.6 5990.7 5799.7 5805.4 5805.9 5876.4 5890.8 19:31:28 INFO - PROCESS | 1955 | 19:31:28 INFO - PROCESS | 1955 | [#1] ext.html Cycles:180 Average:60001.07 Median:37490.16 stddev:121046.99 (322.9%) stddev-sans-first:121303.99 19:31:28 INFO - PROCESS | 1955 | Values: 450.6 451.4 464.8 573.5 618.3 36460.1 38905.8 39062.0 39120.2 39220.8 42235.6 42624.4 42638.8 42716.7 42866.9 9542.3 9770.1 9786.7 9791.3 9792.7 9584.4 9731.1 9751.3 9753.7 9754.5 8970.6 9470.9 9757.6 9769.0 9784.3 9642.6 9673.2 9757.3 9759.4 9778.5 9587.4 9633.4 9637.2 9734.6 9738.2 41080.8 41442.6 41443.6 41455.8 41492.4 3249.0 3402.8 3434.0 3472.9 3630.8 28613.6 28835.8 29102.7 29439.7 29536.3 2271.4 2378.9 2718.9 2757.7 2792.0 480078.0 480570.0 480625.0 480788.0 481475.0 55865.4 57191.7 64663.7 65146.3 65372.7 46376.0 52975.5 68172.0 69370.7 69693.0 16671.7 16879.8 17191.7 17197.0 17246.9 12897.4 12911.8 12915.4 12927.5 12944.7 14345.8 17460.9 17731.0 17792.2 19385.7 6698.4 7668.4 7980.7 8038.3 8070.5 908.2 920.5 959.7 1011.8 1038.6 22669.4 28386.0 28567.3 29038.3 29251.9 1068.9 1088.6 1123.6 1140.4 1213.9 11668.8 12894.5 14883.4 15468.7 15790.9 513318.0 513624.0 527471.0 527707.0 527824.0 59732.7 60151.1 60250.7 60252.7 60412.7 1466.4 1478.6 1491.8 1499.8 1616.2 25135.2 29530.1 29659.6 30467.9 30564.8 46964.5 55451.0 56728.0 56771.7 56966.0 339309.0 344140.0 346382.0 347022.0 347216.0 28578.7 28971.0 28984.7 28993.3 33020.7 33620.5 43408.8 43640.0 43890.1 44047.0 35832.6 36002.7 36079.6 36957.6 36980.3 36516.9 36822.8 36904.4 37684.4 37737.6 36474.8 36514.8 36954.8 37391.1 37589.2 32196.8 32497.4 32956.7 33274.8 33452.3 21524.0 24268.8 24359.0 25048.0 25086.4 19:31:28 INFO - PROCESS | 1955 | 19:31:28 INFO - PROCESS | 1955 | [#2] jquery.html Cycles:180 Average:35515.58 Median:2278.64 stddev:105235.16 (4618.3%) stddev-sans-first:105497.17 19:31:28 INFO - PROCESS | 1955 | Values: 310.2 361.8 363.2 372.8 372.8 19651.2 19670.5 21072.5 21094.5 21100.5 19788.5 19850.2 20488.4 20516.4 20527.5 5776.4 5995.7 6043.2 6043.5 6052.0 4229.8 4291.9 4515.7 5980.8 6657.1 6589.8 6669.3 6693.9 6704.2 6716.7 6675.5 6677.9 6683.7 6684.4 6689.2 3793.8 5446.5 5733.2 5747.1 5757.4 25264.4 25746.2 26045.6 26059.5 26079.2 2013.6 2120.4 2179.3 2269.9 2287.4 14362.6 14410.9 14958.9 15072.2 15170.8 1740.3 1767.6 1784.8 1786.4 1805.3 97688.5 98481.5 99165.0 99904.0 100627.0 10313.6 10565.8 10767.4 10813.7 10875.3 13207.5 13301.2 13308.4 13313.5 13351.1 8089.9 8522.1 8569.8 8775.2 8865.5 8134.4 8353.9 9006.4 9062.5 9179.3 6125.4 6216.2 6223.5 6247.9 6312.6 1746.9 1772.6 1779.5 1808.9 1831.2 939.1 941.6 960.2 1040.8 1053.2 16406.9 20286.6 20924.9 22053.3 22207.0 916.3 940.8 956.4 985.5 1055.7 10983.9 11352.9 11358.8 11365.2 11411.6 624249.0 630454.6 637598.0 639190.0 642569.0 125655.4 127597.0 127864.0 129122.0 131191.0 1085.4 1086.2 1103.8 1104.9 1105.2 18380.1 18438.2 18761.2 18993.2 19019.0 51032.0 53379.5 54033.9 54213.9 54270.0 55821.0 78308.2 78571.1 80209.6 81155.6 6481.2 7382.7 7964.0 8001.3 8049.0 11047.6 11594.5 11973.8 12157.2 12394.3 10465.3 10783.4 11038.2 11077.8 11141.4 10437.6 10675.5 10827.9 11019.8 11031.3 10016.2 10253.3 11045.1 11336.0 11347.4 7656.5 7660.9 7752.9 7827.8 8047.6 7939.8 9884.0 10869.8 11147.2 11151.4 19:31:28 INFO - PROCESS | 1955 | 19:31:28 INFO - PROCESS | 1955 | [#3] mootools.html Cycles:180 Average:6134.00 Median:4997.06 stddev:3252.55 (65.1%) stddev-sans-first:3242.60 19:31:28 INFO - PROCESS | 1955 | Values: 1448.5 1461.2 1551.1 1758.3 1874.8 8046.8 8840.2 8979.1 8984.8 9013.7 8601.0 8873.7 8889.1 8902.1 8939.3 2179.1 2396.2 2472.7 2492.2 2516.9 2376.2 2381.7 2386.4 2388.0 2390.6 2343.7 2374.2 2412.5 2413.3 2413.6 2398.4 2437.2 2446.4 2474.9 2485.0 2464.8 2495.1 2504.9 2507.9 2513.9 8972.0 9054.8 9064.7 9069.0 9101.5 5477.5 5665.5 5665.8 5666.7 5671.3 3400.9 3600.7 3688.0 3789.9 3792.6 1044.3 1067.1 1069.3 1082.2 1083.1 12176.9 12186.3 12188.3 12194.3 12214.5 3948.4 4903.9 4984.9 4990.1 5004.0 10402.2 10421.7 10427.1 10430.3 10438.6 5589.1 5604.4 5643.5 5649.9 5654.2 4494.2 4588.3 4881.1 5070.9 5072.9 3854.6 3949.2 3952.5 3991.2 4031.1 1309.7 1317.2 1320.1 1326.7 1333.9 1157.2 1382.2 1398.8 1425.1 1429.6 8227.3 8301.0 8302.4 8324.8 8344.5 974.0 1227.5 1228.7 1263.4 1272.8 6360.0 6411.6 6422.9 6435.3 6465.8 10304.5 10932.3 10937.5 11090.8 11098.2 10534.3 10747.8 10944.3 11051.0 11060.9 8455.1 8485.4 8616.0 8625.4 8625.8 7951.4 8048.3 8099.8 8108.8 8147.5 9632.9 9765.2 9863.3 9973.0 10004.0 7671.9 10097.8 10125.3 10151.4 10303.7 6458.1 6681.1 6784.6 7153.1 7274.6 8354.9 8385.2 8411.5 8423.7 8437.9 6102.3 7325.2 7352.6 7432.0 7545.0 7250.6 7270.2 7380.2 7402.9 7423.0 7821.6 7935.5 7938.4 7940.8 7940.9 6856.9 6872.2 6935.0 6938.2 6946.0 7139.0 7187.7 7197.4 7203.1 7208.2 19:31:28 INFO - PROCESS | 1955 | 19:31:28 INFO - PROCESS | 1955 | [#4] prototype.html Cycles:180 Average:5805.53 Median:6719.30 stddev:1894.66 (28.2%) stddev-sans-first:1854.80 19:31:28 INFO - PROCESS | 1955 | Values: 325.6 329.8 332.8 333.8 337.6 6690.7 6745.9 6752.3 6756.2 6770.6 6657.9 6705.0 6705.9 6719.7 6736.5 3958.6 4709.4 4774.0 4852.3 4954.8 4284.5 4527.6 4801.9 4840.8 4841.8 4775.2 4776.6 4783.7 4790.2 4852.5 4668.8 4751.4 4854.6 4857.6 4875.7 4149.5 4150.8 4162.5 4177.2 4182.7 6424.1 6434.6 6505.9 6506.0 6508.2 5861.4 5866.4 5872.8 5875.1 5892.2 6718.9 7138.2 7142.2 7145.2 7148.6 4567.0 4585.5 4604.0 4613.5 4647.4 7424.2 7514.0 7523.0 7531.4 7539.6 3991.2 4373.5 4615.5 4648.5 4658.7 3955.4 4710.2 4725.2 4726.8 4746.8 5652.9 5661.9 5663.9 5666.2 5679.0 6828.0 7141.1 7148.4 7161.8 7182.4 1262.8 1460.2 1645.3 1647.4 1651.6 974.1 1002.1 1029.9 1031.6 1057.7 5524.6 6537.3 6744.0 6774.2 6784.7 7485.7 7490.9 7494.4 7496.9 7508.8 6739.9 6741.0 6747.5 6747.6 6759.2 3802.8 3897.3 3942.1 3946.5 3956.0 7775.3 7782.1 7833.5 7839.9 7861.9 6250.4 7683.3 7685.5 7701.5 7711.3 7793.6 7801.7 7810.2 7812.2 7815.0 6633.3 6657.2 7438.4 7470.8 7471.6 5926.5 7161.6 7295.9 7305.5 7306.5 6957.7 7126.3 7183.1 7733.3 7793.0 4662.4 4664.4 4675.1 4678.3 4680.8 5987.6 7158.6 7394.3 7429.6 7431.6 7123.4 7166.6 7172.6 7188.6 7199.7 7148.7 7154.9 7163.0 7164.3 7172.5 7020.3 7035.7 7041.8 7053.3 7057.2 6862.7 7176.4 7189.7 7191.1 7217.9 6725.0 6846.9 6891.8 6980.0 7005.5 19:31:28 INFO - PROCESS | 1955 | 19:31:28 INFO - PROCESS | 1955 | [#5] yui.html Cycles:180 Average:19059.26 Median:643.36 stddev:27617.71 (4292.8%) stddev-sans-first:27660.67 19:31:28 INFO - PROCESS | 1955 | Values: 672.3 756.4 758.7 758.9 767.2 15159.5 15448.4 15456.4 17708.0 18242.7 16513.0 16515.6 16593.3 16609.9 16615.8 758.6 920.1 948.8 949.7 950.7 755.9 916.9 943.5 944.8 945.4 990.3 999.1 999.7 999.9 1000.2 787.6 968.4 987.3 992.6 997.7 738.6 739.7 741.2 741.7 745.8 13802.7 14802.9 15479.4 15597.7 15627.5 12309.5 12355.1 12508.9 12518.4 12830.5 9917.6 10205.3 10241.7 10256.6 10535.1 2953.9 3509.3 3555.1 3598.9 3618.5 89765.6 89964.1 90846.5 91109.5 91387.0 8098.6 9430.7 9479.5 9579.7 9901.3 22169.0 22178.3 22191.0 22226.9 22231.4 7253.1 7373.3 7405.7 7425.7 7592.5 4121.3 4176.8 4177.6 4178.1 4185.7 3498.0 3553.1 3553.2 3553.3 3562.0 644.3 657.7 657.8 668.8 673.0 594.6 612.9 620.5 624.7 628.8 7908.5 8047.2 8152.5 8358.1 8440.6 517.5 584.6 616.9 635.3 642.4 3857.7 3902.4 4000.7 4006.8 4013.6 98858.5 99713.0 101948.3 102157.0 102211.0 65450.4 83072.0 83471.0 83639.0 85313.0 69544.3 69872.6 71516.0 71585.6 73128.0 7729.7 7921.3 7954.0 8008.6 8200.1 51794.7 52688.5 52970.2 53263.8 53276.5 68618.3 69485.9 71223.6 72827.6 72859.0 9872.6 10109.6 10197.8 10246.6 10819.5 9313.9 11168.9 11309.4 11357.3 11518.1 10571.6 10795.2 10880.2 10884.7 10893.5 10419.9 10511.7 10595.4 10597.4 10891.3 10566.7 10584.6 10599.4 10814.9 10851.8 8900.3 9010.1 9045.8 9147.7 9159.3 8688.1 8717.0 8916.0 9339.4 9567.4 19:31:28 INFO - PROCESS | 1955 | -------- Summary: end -------- 19:31:28 INFO - PROCESS | 1955 | 19:31:29 INFO - TEST-INFO | 1955: exit 0 19:31:29 INFO - TEST-OK | dromaeo_css | took 1114734ms 19:31:29 INFO - TEST-START | kraken 19:31:29 INFO - operating with platform_type : mac_ 19:31:29 INFO - Initialising browser for kraken test... 19:31:29 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmphoGO5_/profile http://localhost:51454/getInfo.html) 19:31:31 INFO - PROCESS | 1960 | __metrics Screen width/height:1600/1200 19:31:31 INFO - PROCESS | 1960 | colorDepth:24 19:31:31 INFO - PROCESS | 1960 | Browser inner width/height: 1024/689 19:31:31 INFO - PROCESS | 1960 | __metrics 19:31:31 INFO - PROCESS | 1960 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:31:31 ERROR - PROCESS | 1960 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:31:32 INFO - TEST-INFO | 1960: exit 0 19:31:32 INFO - Browser initialized. 19:31:32 INFO - Running cycle 1/1 for kraken test... 19:31:32 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmphoGO5_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:44 INFO - PROCESS | 1962 | RSS: Main: 244498432 19:31:44 INFO - PROCESS | 1962 | 19:31:47 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51454/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51454/tests/kraken/driver.html?testName=audio-beat-detection) 19:31:47 INFO - PROCESS | 1962 | RSS: Main: 290652160 19:31:47 INFO - PROCESS | 1962 | 19:31:50 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51454/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51454/tests/kraken/driver.html?testName=audio-dft) 19:31:51 INFO - PROCESS | 1962 | RSS: Main: 301305856 19:31:51 INFO - PROCESS | 1962 | 19:31:54 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51454/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51454/tests/kraken/driver.html?testName=audio-fft) 19:31:54 INFO - PROCESS | 1962 | RSS: Main: 287485952 19:31:54 INFO - PROCESS | 1962 | 19:31:56 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51454/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51454/tests/kraken/driver.html?testName=audio-oscillator) 19:31:57 INFO - PROCESS | 1962 | RSS: Main: 289452032 19:31:57 INFO - PROCESS | 1962 | 19:31:59 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51454/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51454/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:32:00 INFO - PROCESS | 1962 | RSS: Main: 291467264 19:32:00 INFO - PROCESS | 1962 | 19:32:02 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51454/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51454/tests/kraken/driver.html?testName=imaging-darkroom) 19:32:03 INFO - PROCESS | 1962 | RSS: Main: 291700736 19:32:03 INFO - PROCESS | 1962 | 19:32:06 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51454/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51454/tests/kraken/driver.html?testName=imaging-desaturate) 19:32:06 INFO - PROCESS | 1962 | RSS: Main: 291811328 19:32:06 INFO - PROCESS | 1962 | 19:32:09 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51454/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51454/tests/kraken/driver.html?testName=json-parse-financial) 19:32:10 INFO - PROCESS | 1962 | RSS: Main: 292212736 19:32:10 INFO - PROCESS | 1962 | 19:32:11 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51454/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51454/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:32:12 INFO - PROCESS | 1962 | RSS: Main: 324878336 19:32:12 INFO - PROCESS | 1962 | 19:32:14 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51454/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51454/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:32:14 INFO - PROCESS | 1962 | RSS: Main: 324534272 19:32:14 INFO - PROCESS | 1962 | 19:32:16 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51454/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51454/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:32:17 INFO - PROCESS | 1962 | RSS: Main: 331128832 19:32:17 INFO - PROCESS | 1962 | 19:32:20 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51454/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:32:20 INFO - PROCESS | 1962 | RSS: Main: 332677120 19:32:20 INFO - PROCESS | 1962 | 19:32:23 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:32:24 INFO - PROCESS | 1962 | RSS: Main: 332890112 19:32:24 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51454/tests/kraken/driver.html?testName=ai-astar) 19:32:26 INFO - PROCESS | 1962 | RSS: Main: 395526144 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | __start_tp_report 19:32:26 INFO - PROCESS | 1962 | _x_x_mozilla_page_load 19:32:26 INFO - PROCESS | 1962 | _x_x_mozilla_page_load_details 19:32:26 INFO - PROCESS | 1962 | |i|pagename|runs| 19:32:26 INFO - PROCESS | 1962 | |0;ai-astar;113;109;111;111;112;113;117;112;113;112 19:32:26 INFO - PROCESS | 1962 | |1;audio-beat-detection;161;154;183;200;139;142;142;147;175;133 19:32:26 INFO - PROCESS | 1962 | |2;audio-dft;184;184;185;185;188;184;186;182;179;182 19:32:26 INFO - PROCESS | 1962 | |3;audio-fft;81;72;84;78;58;57;56;76;78;56 19:32:26 INFO - PROCESS | 1962 | |4;audio-oscillator;96;90;125;80;78;88;114;79;79;115 19:32:26 INFO - PROCESS | 1962 | |5;imaging-gaussian-blur;88;84;87;84;86;84;88;84;87;87 19:32:26 INFO - PROCESS | 1962 | |6;imaging-darkroom;93;93;93;94;92;93;100;149;131;96 19:32:26 INFO - PROCESS | 1962 | |7;imaging-desaturate;85;84;87;84;86;84;85;87;84;87 19:32:26 INFO - PROCESS | 1962 | |8;json-parse-financial;55;56;54;53;55;54;53;63;54;53 19:32:26 INFO - PROCESS | 1962 | |9;json-stringify-tinderbox;66;75;75;73;70;68;67;68;68;68 19:32:26 INFO - PROCESS | 1962 | |10;stanford-crypto-aes;83;82;84;84;83;82;81;82;85;85 19:32:26 INFO - PROCESS | 1962 | |11;stanford-crypto-ccm;134;134;123;134;134;132;130;130;120;119 19:32:26 INFO - PROCESS | 1962 | |12;stanford-crypto-pbkdf2;139;129;138;144;180;174;148;140;140;175 19:32:26 INFO - PROCESS | 1962 | |13;stanford-crypto-sha256-iterative;70;84;95;61;58;89;89;96;87;67 19:32:26 INFO - PROCESS | 1962 | __end_tp_report 19:32:26 INFO - PROCESS | 1962 | __start_cc_report 19:32:26 INFO - PROCESS | 1962 | _x_x_mozilla_cycle_collect,1249 19:32:26 INFO - PROCESS | 1962 | __end_cc_report 19:32:26 INFO - PROCESS | 1962 | __startTimestamp1459305146276__endTimestamp 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | ------- Summary: start ------- 19:32:26 INFO - PROCESS | 1962 | Number of tests: 14 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.50 stddev:2.06 (1.8%) stddev-sans-first:2.17 19:32:26 INFO - PROCESS | 1962 | Values: 113.0 109.0 111.0 111.0 112.0 113.0 117.0 112.0 113.0 112.0 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | [#1] audio-beat-detection Cycles:10 Average:157.60 Median:157.50 stddev:21.91 (13.9%) stddev-sans-first:23.20 19:32:26 INFO - PROCESS | 1962 | Values: 161.0 154.0 183.0 200.0 139.0 142.0 142.0 147.0 175.0 133.0 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.50 stddev:2.47 (1.3%) stddev-sans-first:2.62 19:32:26 INFO - PROCESS | 1962 | Values: 184.0 184.0 185.0 185.0 188.0 184.0 186.0 182.0 179.0 182.0 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | [#3] audio-fft Cycles:10 Average:69.60 Median:77.00 stddev:11.49 (14.9%) stddev-sans-first:11.42 19:32:26 INFO - PROCESS | 1962 | Values: 81.0 72.0 84.0 78.0 58.0 57.0 56.0 76.0 78.0 56.0 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:79.50 stddev:17.51 (22.0%) stddev-sans-first:18.56 19:32:26 INFO - PROCESS | 1962 | Values: 96.0 90.0 125.0 80.0 78.0 88.0 114.0 79.0 79.0 115.0 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.00 stddev:1.73 (2.0%) stddev-sans-first:1.66 19:32:26 INFO - PROCESS | 1962 | Values: 88.0 84.0 87.0 84.0 86.0 84.0 88.0 84.0 87.0 87.0 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:93.00 stddev:19.88 (21.4%) stddev-sans-first:20.73 19:32:26 INFO - PROCESS | 1962 | Values: 93.0 93.0 93.0 94.0 92.0 93.0 100.0 149.0 131.0 96.0 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.50 stddev:1.34 (1.6%) stddev-sans-first:1.41 19:32:26 INFO - PROCESS | 1962 | Values: 85.0 84.0 87.0 84.0 86.0 84.0 85.0 87.0 84.0 87.0 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.50 stddev:2.98 (5.5%) stddev-sans-first:3.16 19:32:26 INFO - PROCESS | 1962 | Values: 55.0 56.0 54.0 53.0 55.0 54.0 53.0 63.0 54.0 53.0 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:69.00 stddev:3.33 (4.8%) stddev-sans-first:3.23 19:32:26 INFO - PROCESS | 1962 | Values: 66.0 75.0 75.0 73.0 70.0 68.0 67.0 68.0 68.0 68.0 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:1.37 (1.6%) stddev-sans-first:1.45 19:32:26 INFO - PROCESS | 1962 | Values: 83.0 82.0 84.0 84.0 83.0 82.0 81.0 82.0 85.0 85.0 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:133.00 stddev:6.04 (4.5%) stddev-sans-first:6.13 19:32:26 INFO - PROCESS | 1962 | Values: 134.0 134.0 123.0 134.0 134.0 132.0 130.0 130.0 120.0 119.0 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:146.00 stddev:18.39 (12.6%) stddev-sans-first:19.01 19:32:26 INFO - PROCESS | 1962 | Values: 139.0 129.0 138.0 144.0 180.0 174.0 148.0 140.0 140.0 175.0 19:32:26 INFO - PROCESS | 1962 | 19:32:26 INFO - PROCESS | 1962 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.60 Median:88.00 stddev:14.22 (16.2%) stddev-sans-first:14.65 19:32:26 INFO - PROCESS | 1962 | Values: 70.0 84.0 95.0 61.0 58.0 89.0 89.0 96.0 87.0 67.0 19:32:26 INFO - PROCESS | 1962 | -------- Summary: end -------- 19:32:26 INFO - PROCESS | 1962 | 19:32:27 INFO - TEST-INFO | 1962: exit 0 19:32:27 INFO - TEST-OK | kraken | took 57647ms 19:32:27 INFO - SUITE-END | took 1172s 19:32:27 INFO - Completed test suite (00:19:32) 19:32:27 INFO - javascript benchmark 19:32:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3403.2002479417333, 3452.4130897747395, 3480.808555529448, 3485.477178423237, 3524.7885126892375, 5499.532539734128, 5554.555635549156, 5609.35492418372, 5624.10014397696, 5627.155926611005, 5600.0759874620635, 5625.578081643883, 5731.770729170828, 5780.855478613037, 5811.418858114186, 5052.621053421009, 5071.290019397287, 5093.337866077405, 5108.591312694975, 5163.3545806774155, 4502.932456013146, 4838.298446725223, 5204.0, 5234.345706786652, 5243.868903277429, 4999.600031997432, 5082.669626474304, 5112.872178195537, 5143.151380022292, 5186.299849520323, 5082.847514574569, 5096.490350964911, 5098.847034588968, 5103.515166059218, 5105.055564720538, 5030.245463180516, 5032.798688052473, 5051.191809310492, 5057.418396884369, 5068.847934561969, 5519.061759500854, 5530.695811730353, 5534.059209934321, 5544.528715059225, 5563.109902415635, 6104.816855494342, 6107.674343494563, 6120.938790612081, 6125.509959203253, 6193.256809182927, 6103.786367477162, 6195.411435913581, 6252.812415627538, 6272.843178920518, 6280.654563998978, 5728.942710572925, 5757.740901659394, 5763.6541807491685, 5765.192872997742, 5766.538676905838, 6135.7852475164045, 6211.3167551569295, 6252.093446450239, 6259.4679452246155, 6275.0, 6076.726547305382, 6085.482733967574, 6086.908696369558, 6088.299845517822, 6099.9390006099375, 6194.5973511721595, 6199.969000155061, 6200.627962322275, 6217.067439884054, 6224.284207316126, 5981.910271345933, 6060.0, 6103.877922441615, 6106.175666285084, 6124.908126378108, 6108.9795837225665, 6120.782376608313, 6122.2353486564425, 6131.399973055325, 6141.355157708465, 4824.710517368969, 4829.44461386945, 4829.589484893753, 4840.515948405131, 4870.366852309177, 3613.8735144269826, 4354.8258069677495, 4360.302351623725, 4366.454193225847, 4381.9342709859375, 5604.215409842625, 5633.126865335879, 5639.943600563942, 5694.5159661428415, 5700.40145784695, 6183.81448556544, 6246.593971391845, 6253.093301471261, 6261.8747625047245, 6303.464205542488, 5478.315210598676, 5542.944570554324, 5578.860528486739, 5591.6365436246515, 5611.7474713637985, 5290.206469029677, 5319.069162896478, 5347.224652425377, 5362.65142765719, 5380.381256155514, 6252.499800015988, 6260.780872669435, 6273.874522509615, 6280.340564240689, 6284.183056202664, 6091.1472393864005, 6176.28972668131, 6236.656983865931, 6237.126802247598, 6248.812535623939, 6217.813465596039, 6259.217597800275, 6295.213098362705, 6297.338779428094, 6303.086052522267, 5174.275601415729, 6065.059915713072, 6071.332153463204, 6131.621347939075, 6190.876182476235, 6207.255129384323, 6214.4407003369915, 6216.844578885564, 6229.345918678655, 6230.127782110599, 6059.0, 6062.575619706578, 6079.209702738615, 6092.664903430354, 6094.238220222473, 5616.0733478977145, 5865.0, 5873.676947767914, 5893.057110862242, 5893.351731309467, 5784.94215057844, 5806.042003069446, 5813.94186058134, 5819.418058194146, 5833.387494313036, 5903.2325797646035, 5913.58604897653, 5930.199423077829, 5987.6108052976415, 5990.7004649768205, 5799.652020878761, 5805.419458054161, 5805.94194058054, 5876.382979787061, 5890.793822216202], "unit": "score", "name": "dojo.html", "value": 5617.201200404774}, {"lowerIsBetter": false, "replicates": [450.6214779585148, 451.38836876032974, 464.80942813446495, 573.4580821124038, 618.2550027217202, 36460.08849778757, 38905.80547097264, 39062.0, 39120.21759564807, 39220.80389598055, 42235.57764422355, 42624.36063459051, 42638.786806066004, 42716.71849844502, 42866.92832679184, 9542.332036757447, 9770.071843174923, 9786.706398808046, 9791.265655075862, 9792.657256996006, 9584.377015494005, 9731.075547822946, 9751.26865485088, 9753.707388778312, 9754.46350450725, 8970.59632316544, 9470.863496380443, 9757.609695612167, 9768.951155244215, 9784.26618003649, 9642.566084526177, 9673.226141908666, 9757.268204884662, 9759.414435133915, 9778.462184579845, 9587.424754514752, 9633.421994680342, 9637.18083962864, 9734.610615575368, 9738.220942324597, 41080.794596026826, 41442.58557414418, 41443.585564144276, 41455.7927210365, 41492.37761433581, 3248.9837550812094, 3402.795832250048, 3434.0384692286198, 3472.878449254264, 3630.8366123524506, 28613.57079643807, 28835.84656613733, 29102.70897291021, 29439.67521461518, 29536.26159346012, 2271.432141964509, 2378.881055947196, 2718.932026699348, 2757.7104404037686, 2791.9720802791917, 480078.0, 480570.0, 480625.0, 480788.0, 481475.0, 55865.44134558603, 57191.71404143036, 64663.67668161723, 65146.348536514975, 65372.67313663401, 46376.0, 52975.47024529705, 68171.97742033874, 69370.65314673496, 69693.0, 16671.749923751155, 16879.831201687826, 17191.656166876593, 17196.968181909124, 17246.91376543109, 12897.355132243538, 12911.806322905164, 12915.418806153746, 12927.482900684055, 12944.741105177844, 14345.78481322781, 17460.91269543644, 17731.0, 17792.199351029234, 19385.72197094983, 6698.397144256943, 7668.424868134912, 7980.720674776355, 8038.276555110068, 8070.538485761782, 908.1644886704116, 920.5259291464901, 959.7072892767773, 1011.7976404719086, 1038.5586125896614, 22669.433264168198, 28386.006489772757, 28567.28581785472, 29038.274043148667, 29251.853740731585, 1068.9144868410665, 1088.6189833558349, 1123.646051493777, 1140.3556990300453, 1213.8968187704145, 11668.76662466746, 12894.48422063107, 14883.404663813326, 15468.690626187414, 15790.9210453947, 513318.0, 513624.0, 527471.0, 527707.0, 527824.0, 59732.70133649391, 60151.09773353403, 60250.69874650599, 60252.698736506034, 60412.697936510034, 1466.3548038862866, 1478.64512516993, 1491.8135233095863, 1499.8125234345707, 1616.2080580515462, 25135.24594262175, 29530.114096577137, 29659.555106673848, 30467.933622324, 30564.847175763978, 46964.53035469601, 55451.0, 56728.0, 56771.71614141903, 56966.0, 339309.0, 344140.0, 346382.0, 347022.0, 347216.0, 28578.714212857605, 28971.0, 28984.710152898202, 28993.275168120967, 33020.66979330272, 33620.495692564145, 43408.782956085015, 43640.0, 43890.122197556506, 44047.0, 35832.64167358293, 36002.73990410428, 36079.639203608676, 36957.63042369542, 36980.26039479142, 36516.88745673776, 36822.8158859204, 36904.44643330406, 37684.43473347847, 37737.62262377341, 36474.8176259117, 36514.8174259127, 36954.815225923696, 37391.06522336963, 37589.248215035, 32196.83901580477, 32497.35005299928, 32956.67043329632, 33274.835380762524, 33452.33095338031, 21524.0, 24268.75731242665, 24359.0, 25048.0, 25086.37284067913], "unit": "score", "name": "ext.html", "value": 19380.3723557824}, {"lowerIsBetter": false, "replicates": [310.2352700593039, 361.75942997906395, 363.2136424640653, 372.7968257299773, 372.82290911816875, 19651.213951441943, 19670.508237294074, 21072.473188170265, 21094.472638184052, 21100.472488187803, 19788.50528736782, 19850.205991760347, 20488.385348439533, 20516.38450846477, 20527.486812829688, 5776.364599894008, 5995.730192141364, 6043.214382130317, 6043.486303664194, 6052.0, 4229.767362795045, 4291.935620965688, 4515.706479078865, 5980.760769569212, 6657.101291325657, 6589.769358072468, 6669.333066693341, 6693.933060669379, 6704.229013663418, 6716.6977486013, 6675.499337549654, 6677.866442671144, 6683.699233534503, 6684.431823295025, 6689.163854518185, 3793.8103094845146, 5446.509814116748, 5733.168690539848, 5747.109198074305, 5757.395473475267, 25264.368390790194, 25746.227613171635, 26045.609315860278, 26059.478810423687, 26079.217623471326, 2013.6375452418558, 2120.427484579155, 2179.3154280193417, 2269.8751568663715, 2287.4052746286084, 14362.64093397663, 14410.92794536031, 14958.925205373904, 15072.246387680681, 15170.772438413433, 1740.26908698347, 1767.6287979524316, 1784.7506745278356, 1786.4100950154373, 1805.3139806873305, 97688.51155744247, 98481.5075924623, 99165.0, 99903.99999999927, 100626.99999999927, 10313.639022634172, 10565.841512377321, 10767.3539587625, 10813.729656758487, 10875.293105948089, 13207.471701131846, 13301.201927884358, 13308.401121949535, 13313.46746130144, 13351.132176408502, 8089.919100809035, 8522.138013562002, 8569.785755356166, 8775.210231079234, 8865.468071915706, 8134.430589858772, 8353.874691879626, 9006.369554131279, 9062.456252624863, 9179.311551633655, 6125.387461253839, 6216.160818289473, 6223.471004964629, 6247.937520624827, 6312.5581209314905, 1746.9301227950994, 1772.5657213982656, 1779.4839496546115, 1808.8643351748408, 1831.230883029131, 939.0984654731398, 941.5574679900436, 960.1934375124929, 1040.8282633365561, 1053.1890444357803, 16406.917965410095, 20286.59426811485, 20924.895375523025, 22053.33839984803, 22207.0, 916.3219217778795, 940.8494640857567, 956.3521286547374, 985.4924713772413, 1055.7413433708637, 10983.890161098287, 11352.886471135349, 11358.772824543463, 11365.204435689588, 11411.60059397917, 624249.0, 630454.6499885009, 637598.0, 639190.0, 642569.0, 125655.37172314263, 127597.0, 127864.0, 129122.0, 131191.0, 1085.3650614390513, 1086.1745073743853, 1103.7957977774138, 1104.867415910112, 1105.165599972016, 18380.063862002087, 18438.170282337058, 18761.249550017845, 18993.24027038903, 19019.0, 51032.0, 53379.46620533745, 54033.919321614136, 54213.915721686135, 54270.0, 55821.0, 78308.2169178301, 78571.0714464286, 80209.59895200486, 81155.5942220285, 6481.222253329631, 7382.741604043833, 7964.0, 8001.279884810395, 8049.034115906129, 11047.558097676003, 11594.47824847867, 11973.820392694292, 12157.209781364183, 12394.3183124929, 10465.267431280043, 10783.352998820095, 11038.17213708991, 11077.833832492357, 11141.387223702774, 10437.634682786065, 10675.466226688479, 10827.945860270964, 11019.83470247931, 11031.282966607145, 10016.248781341283, 10253.33413312559, 11045.061169800336, 11336.0, 11347.37589432589, 7656.4640475168435, 7660.885086723815, 7752.92247077522, 7827.804304892195, 8047.557384343683, 7939.84120317602, 9884.0, 10869.78260434771, 11147.219694621623, 11151.386673733023], "unit": "score", "name": "jquery.html", "value": 9621.530754392363}, {"lowerIsBetter": false, "replicates": [1448.4640682947297, 1461.1525315317115, 1551.0771091200736, 1758.2791055667178, 1874.784399794024, 8046.758597242085, 8840.160184782444, 8979.14698103679, 8984.820303593924, 9013.72958811235, 8601.010883748371, 8873.68942087027, 8889.111088891108, 8902.109789021095, 8939.329550283723, 2179.1065663078143, 2396.1613435297595, 2472.7156377016604, 2492.190038237571, 2516.924492265235, 2376.2158487699103, 2381.6665666806575, 2386.3914701751028, 2387.988060059697, 2390.5696974544576, 2343.6953196084487, 2374.2165085521824, 2412.529556736437, 2413.3122060212845, 2413.553492603874, 2398.436367453647, 2437.244454219198, 2446.425090103824, 2474.9010039598393, 2485.005997600965, 2464.827462077655, 2495.089292408276, 2504.8622325772076, 2507.924762257135, 2513.9245822625167, 8972.0, 9054.77363065922, 9064.728058158265, 9069.0, 9101.499417532099, 5477.534409575151, 5665.54675625953, 5665.830025099253, 5666.716664166816, 5671.347795003545, 3400.897973060812, 3600.7119430445764, 3688.0226739913946, 3789.8863034108745, 3792.6207379262128, 1044.2977945948132, 1067.114295135036, 1069.2996087562658, 1082.2370228988623, 1083.128081894075, 12176.878231217663, 12186.329751863645, 12188.329641869694, 12194.268343899306, 12214.450349734283, 3948.3879998599687, 4903.926441103386, 4984.850454486371, 4990.126727822617, 5004.0, 10402.219833512365, 10421.739456513647, 10427.113695335982, 10430.322029068238, 10438.582456701646, 5589.105743081088, 5604.439556044363, 5643.463870932255, 5649.915251271234, 5654.180143879114, 4494.16857881293, 4588.334691469719, 4881.072596206709, 5070.873228169326, 5072.923906141411, 3854.5952674969285, 3949.2299001694396, 3952.5454572724507, 3991.221711766236, 4031.113155105872, 1309.7249577588814, 1317.157019507516, 1320.148504214776, 1326.681596416853, 1333.8932885369147, 1157.1610582327912, 1382.1706975814432, 1398.8181536400202, 1425.1164278147614, 1429.6068581140062, 8227.341812655093, 8300.958495207486, 8302.418830681914, 8324.791880202922, 8344.499330040217, 973.9513024348754, 1227.5212667059855, 1228.662117917562, 1263.3809433377762, 1272.7772639788, 6360.0, 6411.6153030818305, 6422.903656445157, 6435.2599451063725, 6465.77369792055, 10304.484775761182, 10932.344059356465, 10937.4531273436, 11090.833637495443, 11098.167637427225, 10534.315269507457, 10747.764007139123, 10944.343339399662, 11051.005409513182, 11060.889391106148, 8455.069942306342, 8485.363597730071, 8615.956920215483, 8625.353098517637, 8625.827483450421, 7951.443398962017, 8048.275655191061, 8099.757007289791, 8108.797280068045, 8147.470414423044, 9632.9036709632, 9765.169960553148, 9863.309568330147, 9972.955544113294, 10004.0, 7671.923280767121, 10097.798044038931, 10125.291229614151, 10151.441670708182, 10303.742406439898, 6458.128152699325, 6681.1314529110905, 6784.559003664746, 7153.141623005273, 7274.636268186676, 8354.916450835413, 8385.245327920517, 8411.45325553837, 8423.663053478038, 8437.915620843713, 6102.267727872683, 7325.230850760593, 7352.595607241653, 7432.0, 7544.962275188589, 7250.564966102051, 7270.200277969525, 7380.151282602569, 7402.851942961003, 7422.96288518554, 7821.648025838737, 7935.484193527403, 7938.404619653434, 7940.841183176189, 7940.920590794018, 6856.862862742817, 6872.175338959357, 6934.965325173342, 6938.167419909643, 6945.992831039572, 7139.0, 7187.748428804966, 7197.424206063398, 7203.063601731741, 7208.171060328129], "unit": "score", "name": "mootools.html", "value": 4999.450771360943}, {"lowerIsBetter": false, "replicates": [325.6141472355259, 329.80211872876276, 332.8252667349642, 333.7797053944397, 337.6252359880532, 6690.6654667266685, 6745.898811517831, 6752.257251702309, 6756.223034351045, 6770.5937643741345, 6657.866842663144, 6704.966475167629, 6705.865882682343, 6719.697613607387, 6736.528443008991, 3958.6437220650137, 4709.364235828154, 4774.021325628255, 4852.320675105488, 4954.777035033432, 4284.528701842794, 4527.56988086133, 4801.855944321676, 4840.782164802592, 4841.8305359312435, 4775.212090005145, 4776.593989510896, 4783.71297722136, 4790.23356262998, 4852.490488498692, 4668.789904454291, 4751.406074240703, 4854.587360074363, 4857.587105096071, 4875.658703890729, 4149.543550209474, 4150.813213405404, 4162.500499939996, 4177.22721296558, 4182.728122672047, 6424.100625912376, 6434.58175218614, 6505.902411463831, 6506.024096385533, 6508.186476690414, 5861.413858614147, 5866.384029676865, 5872.823815285506, 5875.089361149029, 5892.234009578728, 6718.899216511756, 7138.214796372395, 7142.21435642079, 7145.178304494998, 7148.571085734872, 4567.0, 4585.541445855421, 4604.033153037833, 4613.469451013143, 4647.442306923191, 7424.220456852061, 7514.0231769870115, 7523.0, 7531.359834414081, 7539.585322807244, 3991.1618560102124, 4373.453318335208, 4615.492295847454, 4648.465426475931, 4658.720476771405, 3955.446237526691, 4710.222813235846, 4725.243960966229, 4726.79466735987, 4746.833860814855, 5652.8869422611315, 5661.915071273934, 5663.943360566424, 5666.15007748841, 5679.0, 6828.0, 7141.071660684078, 7148.39238664709, 7161.785146445615, 7182.42540596751, 1262.8484581850237, 1460.160407765518, 1645.3171933647402, 1647.4316360855485, 1651.587103224194, 974.055166488505, 1002.0880998291519, 1029.912457441126, 1031.633770011635, 1057.7249915021996, 5524.558035357242, 6537.346265373425, 6743.954687023519, 6774.153230846145, 6784.694688739019, 7485.700571977169, 7490.85018299631, 7494.362979146725, 7496.925030749622, 7508.774736757797, 6739.865202695919, 6740.966295168493, 6747.460203183734, 6747.628880411527, 6759.2226893906845, 3802.771833689932, 3897.3179693553516, 3942.073612701013, 3946.5264168299987, 3955.960440395617, 7775.261350171724, 7782.143964163937, 7833.49082309648, 7839.882401763978, 7861.921380786119, 6250.437460628475, 7683.346915512132, 7685.4620176587105, 7701.460897737216, 7711.344535714527, 7793.61031948389, 7801.687932482637, 7810.179931107152, 7812.218778122256, 7814.984052073308, 6633.270340262664, 6657.201135863727, 7438.442116841366, 7470.775876723707, 7471.626418679153, 5926.4666180044005, 7161.57030578167, 7295.927040729524, 7305.488615796843, 7306.452016098708, 6957.678041172161, 7126.2873712628325, 7183.138023437221, 7733.265339792711, 7793.025871766029, 4662.417197850269, 4664.440267167962, 4675.064987002545, 4678.321643361625, 4680.812767489262, 5987.640741555347, 7158.642067896689, 7394.334509894135, 7429.628518574158, 7431.554106753612, 7123.430125590044, 7166.57000579946, 7172.569645821268, 7188.568685878864, 7199.6760145794615, 7148.714051437884, 7154.856902862018, 7162.964185179041, 7164.283571642794, 7172.462065345225, 7020.297970202939, 7035.6833942471685, 7041.753538626123, 7053.294670532906, 7057.188423331382, 6862.691178896862, 7176.354128128493, 7189.7483588074165, 7191.137063552407, 7217.855642887218, 6724.991251312146, 6846.931530684828, 6891.75878844238, 6979.953007048984, 7005.474589405713], "unit": "score", "name": "prototype.html", "value": 5163.555572512881}, {"lowerIsBetter": false, "replicates": [672.3377473188909, 756.4364548411432, 758.6510205305563, 758.8520238553481, 767.2251026463271, 15159.545213643594, 15448.382064717413, 15456.381744730212, 17708.0, 18242.726359104625, 16513.0, 16515.58711032225, 16593.253303601337, 16609.920355176906, 16615.83384166158, 758.5789886612928, 920.052346083535, 948.8434408322653, 949.7150854743584, 950.7100334398006, 755.9017327747385, 916.9174774270315, 943.4905151218334, 944.7590864329586, 945.4091193004373, 990.3315262198023, 999.0808456220295, 999.7100840756171, 999.9250056245775, 1000.1998401278984, 787.5707739282105, 968.4383057826444, 987.2940847294183, 992.602958816472, 997.7405874472616, 738.6048464071749, 739.7484855149221, 741.2328240271294, 741.7070257248357, 745.7725393754903, 13802.65493362674, 14802.925985370004, 15479.380824766995, 15597.68804623901, 15627.531174064796, 12309.507619695201, 12355.135140540166, 12508.874911250861, 12518.374081295899, 12830.486780528767, 9917.603295868228, 10205.336653117523, 10241.74395640115, 10256.589736410535, 10535.10451611614, 2953.8670759815645, 3509.298140371936, 3555.1467647764352, 3598.946015809765, 3618.4572314152824, 89765.55117224372, 89964.10035899622, 90846.54576727074, 91109.54445227732, 91386.99999999933, 8098.635561399751, 9430.669926552539, 9479.526023698925, 9579.664711735195, 9901.306908516335, 22169.0, 22178.33464996053, 22191.0, 22226.88886555589, 22231.444213894458, 7253.057102576737, 7373.29953654402, 7405.703771849174, 7425.702971881173, 7592.506487078323, 4121.319982202903, 4176.791160441966, 4177.582241775798, 4178.05993651426, 4185.727927684691, 3497.965020349764, 3553.058439513531, 3553.1650062235353, 3553.34263161316, 3561.9643803561635, 644.2856929799708, 657.7076045570382, 657.8322527755391, 668.752561552219, 673.0035384722103, 594.5986459140063, 612.9233845769279, 620.5470006894992, 624.6689254695019, 628.7556209956603, 7908.52548847071, 8047.235512626291, 8152.510849349058, 8358.080611132771, 8440.57797110142, 517.4721783780523, 584.5791030458148, 616.892043892317, 635.3233805996599, 642.4250295985161, 3857.672097871656, 3902.35611124167, 4000.699947503949, 4006.759594424344, 4013.607131328635, 98858.51712224323, 99713.0, 101948.27594826542, 102157.0, 102211.0, 65450.36374090686, 83072.0, 83471.0, 83639.0, 85313.0, 69544.26139346557, 69872.60254794876, 71516.0, 71585.6420717893, 73128.0, 7729.6521656524465, 7921.32668723165, 7954.0, 8008.639611217625, 8200.138985406445, 51794.74102629463, 52688.47311526836, 52970.2054469191, 53263.82502299092, 53276.4672353287, 68618.31381686318, 69485.88225883835, 71223.5755284881, 72827.63586182035, 72859.0, 9872.605095796087, 10109.595616175564, 10197.796044079225, 10246.590136394461, 10819.459027048459, 9313.86029209576, 11168.880417535624, 11309.434528273388, 11357.318560886373, 11518.136139789716, 10571.577136914744, 10795.19036072282, 10880.238383313408, 10884.673459796219, 10893.509792059534, 10419.94790026045, 10511.737206569896, 10595.417252051211, 10597.364158150227, 10891.346519208873, 10566.735831604272, 10584.629537966135, 10599.364038157735, 10814.89185108139, 10851.782964340511, 8900.287976961697, 9010.098990100938, 9045.819083618422, 9147.725568232963, 9159.267258619428, 8688.13118688126, 8716.956415217883, 8915.955420222857, 9339.392939458914, 9567.425954442755], "unit": "score", "name": "yui.html", "value": 6981.808131375302}], "name": "dromaeo_css", "value": 7574.13813756172}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 111.0, 111.0, 112.0, 113.0, 117.0, 112.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [161.0, 154.0, 183.0, 200.0, 139.0, 142.0, 142.0, 147.0, 175.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 157.6}, {"lowerIsBetter": true, "replicates": [184.0, 184.0, 185.0, 185.0, 188.0, 184.0, 186.0, 182.0, 179.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.9}, {"lowerIsBetter": true, "replicates": [81.0, 72.0, 84.0, 78.0, 58.0, 57.0, 56.0, 76.0, 78.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.6}, {"lowerIsBetter": true, "replicates": [96.0, 90.0, 125.0, 80.0, 78.0, 88.0, 114.0, 79.0, 79.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 94.4}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 87.0, 84.0, 86.0, 84.0, 88.0, 84.0, 87.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 94.0, 92.0, 93.0, 100.0, 149.0, 131.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 103.4}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 87.0, 84.0, 86.0, 84.0, 85.0, 87.0, 84.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 85.3}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 54.0, 53.0, 55.0, 54.0, 53.0, 63.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [66.0, 75.0, 75.0, 73.0, 70.0, 68.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 84.0, 84.0, 83.0, 82.0, 81.0, 82.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [134.0, 134.0, 123.0, 134.0, 134.0, 132.0, 130.0, 130.0, 120.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.0}, {"lowerIsBetter": true, "replicates": [139.0, 129.0, 138.0, 144.0, 180.0, 174.0, 148.0, 140.0, 140.0, 175.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [70.0, 84.0, 95.0, 61.0, 58.0, 89.0, 89.0, 96.0, 87.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 79.6}], "name": "kraken", "value": 1459.5999999999997}]} 19:32:27 INFO - Return code: 0 19:32:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:32:27 ERROR - # TBPL SUCCESS # 19:32:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:32:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:32:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:32:27 INFO - 2016-03-29 19:32:27.599 screenresolution[1966:13430] starting screenresolution argv=screenresolution get 19:32:27 INFO - 2016-03-29 19:32:27.601 screenresolution[1966:13430] Display 0: 1600x1200x32@60 19:32:27 INFO - 2016-03-29 19:32:27.607 screenresolution[1967:13433] starting screenresolution argv=screenresolution list 19:32:27 INFO - Available Modes on Display 0 19:32:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:32:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:32:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:32:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:32:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:32:27 INFO - Intel Iris: 19:32:27 INFO - Chipset Model: Intel Iris 19:32:27 INFO - Type: GPU 19:32:27 INFO - Bus: Built-In 19:32:27 INFO - VRAM (Dynamic, Max): 1536 MB 19:32:27 INFO - Vendor: Intel (0x8086) 19:32:27 INFO - Device ID: 0x0a2e 19:32:27 INFO - Revision ID: 0x0009 19:32:27 INFO - Displays: 19:32:27 INFO - Display: 19:32:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:32:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:32:27 INFO - Display Serial Number: 1600x1200 60 19:32:27 INFO - Main Display: Yes 19:32:27 INFO - Mirror: Off 19:32:27 INFO - Online: Yes 19:32:27 INFO - Rotation: Supported 19:32:27 INFO - Return code: 0 19:32:27 INFO - Running post-action listener: _resource_record_post_action 19:32:27 INFO - Running post-run listener: _resource_record_post_run 19:32:28 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 569344; Write bytes: 704408064; Read time: 11; Write time: 1846 19:32:28 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 381428224; Write bytes: 376113152; Read time: 28442; Write time: 692 19:32:28 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 565248; Write bytes: 299213312; Read time: 10; Write time: 1095 19:32:28 INFO - Running post-run listener: _upload_blobber_files 19:32:28 INFO - Blob upload gear active. 19:32:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:32:28 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 19:32:28 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'] 19:32:28 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 19:32:29 INFO - (blobuploader) - INFO - Open directory for files ... 19:32:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:32:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:32:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:30 INFO - (blobuploader) - INFO - Done attempting. 19:32:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:32:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:32:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:31 INFO - (blobuploader) - INFO - Done attempting. 19:32:31 INFO - (blobuploader) - INFO - Iteration through files over. 19:32:31 INFO - Return code: 0 19:32:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:32:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:32:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/601eb847c1324ec4ee1e6998e283175a3204efc10bc34c73864d89bd18ead0718f533607fa5787c30efeacc47406dad41e71456293430b8a3e92995d91f79dc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8a71b6cbc1c14ee347cef771a80b81e247900d4fb279cf0b2de66db5d63d72fbbff7051608ae8aa9938c84d2a248355ffce24f57c219f1f178bbdf4be6a0519"} 19:32:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:32:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:32:31 INFO - Contents: 19:32:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/601eb847c1324ec4ee1e6998e283175a3204efc10bc34c73864d89bd18ead0718f533607fa5787c30efeacc47406dad41e71456293430b8a3e92995d91f79dc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8a71b6cbc1c14ee347cef771a80b81e247900d4fb279cf0b2de66db5d63d72fbbff7051608ae8aa9938c84d2a248355ffce24f57c219f1f178bbdf4be6a0519"} 19:32:31 INFO - Running post-run listener: copy_logs_to_upload_dir 19:32:31 INFO - Copying logs to upload dir... 19:32:31 INFO - mkdir: /builds/slave/test/build/upload/logs 19:32:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.607354 ========= master_lag: 18.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-03-29 19:32:49.458958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-03-29 19:32:49.464393) ========= 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.2WcxfE44nU/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.ddFAMDucbK/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/601eb847c1324ec4ee1e6998e283175a3204efc10bc34c73864d89bd18ead0718f533607fa5787c30efeacc47406dad41e71456293430b8a3e92995d91f79dc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8a71b6cbc1c14ee347cef771a80b81e247900d4fb279cf0b2de66db5d63d72fbbff7051608ae8aa9938c84d2a248355ffce24f57c219f1f178bbdf4be6a0519"} build_url:https://queue.taskcluster.net/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010996 build_url: 'https://queue.taskcluster.net/v1/task/YlV1MQ4fRy6ha3NGj84uBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/601eb847c1324ec4ee1e6998e283175a3204efc10bc34c73864d89bd18ead0718f533607fa5787c30efeacc47406dad41e71456293430b8a3e92995d91f79dc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8a71b6cbc1c14ee347cef771a80b81e247900d4fb279cf0b2de66db5d63d72fbbff7051608ae8aa9938c84d2a248355ffce24f57c219f1f178bbdf4be6a0519"}' ========= master_lag: 2.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-03-29 19:32:51.857392) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 19:32:51.857728) ========= 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.2WcxfE44nU/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.ddFAMDucbK/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.005200 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 19:32:51.910323) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 19:32:51.910632) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 19:32:51.919963) ========= ========= Total master_lag: 20.68 =========